fnichol/chef-rvm — Issue #51: private method `chomp' called for nil:NilClass
Author: miah
Created: 2011-10-31 22:55:33+00:00
State: open

Hi,

Pinged you on twitter about this about a month ago. I've updated to the latest release of your cookbook(0.8.4), and I'm still seeing this issue.

Thanks
-Miah

Massive log:
[Mon, 31 Oct 2011 22:26:33 +0000] INFO: Processing template[/etc/rvmrc] action create (rvm::system_install line 135)
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: Not storing cookbooks/rvm/templates/default/rvmrc.erb, as the cache is up to date.
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: Current content's checksum: 46241de8af5d3e5ab9d01f128992a6d6f44412cfb730963c964593c7f94e772c
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: Rendered content's checksum: 46241de8af5d3e5ab9d01f128992a6d6f44412cfb730963c964593c7f94e772c
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: template[/etc/rvmrc] content has not changed.
[Mon, 31 Oct 2011 22:26:33 +0000] INFO: Processing execute[install system-wide RVM] action run (rvm::system_install line 69)
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: Executing bash -c "source /etc/profile.d/rvm.sh && type rvm | head -1 | grep -q '^rvm is a function$'"
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: ---- Begin output of bash -c "source /etc/profile.d/rvm.sh && type rvm | head -1 | grep -q '^rvm is a function$'" ----
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: STDOUT:
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: STDERR: bash: line 0: type: write error: Broken pipe
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: ---- End output of bash -c "source /etc/profile.d/rvm.sh && type rvm | head -1 | grep -q '^rvm is a function$'" ----
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: Ran bash -c "source /etc/profile.d/rvm.sh && type rvm | head -1 | grep -q '^rvm is a function$'" returned 0
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: Skipping execute[install system-wide RVM] due to not_if
[Mon, 31 Oct 2011 22:26:33 +0000] INFO: Processing execute[upgrade system-wide RVM to none] action run (rvm::system_install line 105)
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: Skipping execute[upgrade system-wide RVM to none] due to only_if
[Mon, 31 Oct 2011 22:26:33 +0000] INFO: Processing rvm_default_ruby[ruby-1.9.2-p290] action create (rvm::system line 32)
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: RVM::Shell::ChefWrapper subprocess executing with environment of: [{}].
[Mon, 31 Oct 2011 22:26:33 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [source '/usr/lib/ruby/gems/1.8/gems/rvm-1.9.2/lib/rvm/shell/shell_wrapper.sh'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:34 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [export rvm_path='/usr/local/rvm'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:34 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [source '/usr/local/rvm/scripts/rvm'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:34 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [rvm 'use' 'default'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:34 +0000] DEBUG: RVM::Shell::ChefWrapper executing: [rvm 'list' 'default' 'string'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: Chef::Provider::RvmDefaultRuby: `ruby-1.9.2-p290' is already default, so skipping
[Mon, 31 Oct 2011 22:26:35 +0000] INFO: Processing rvm_global_gem[bundler] action install (rvm::system line 36)
[Mon, 31 Oct 2011 22:26:35 +0000] INFO: Processing execute[Add bundler to /usr/local/rvm/gemsets/global.gems] action run (/var/cache/chef/cookbooks/rvm/providers/global_gem.rb line 102)
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: Executing grep -q "^bundler" "/usr/local/rvm/gemsets/global.gems"
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: ---- Begin output of grep -q "^bundler" "/usr/local/rvm/gemsets/global.gems" ----
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: STDOUT:
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: STDERR:
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: ---- End output of grep -q "^bundler" "/usr/local/rvm/gemsets/global.gems" ----
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: Ran grep -q "^bundler" "/usr/local/rvm/gemsets/global.gems" returned 0
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: Skipping execute[Add bundler to /usr/local/rvm/gemsets/global.gems] due to not_if
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: RVM::Shell::ChefWrapper subprocess executing with environment of: [{}].
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [source '/usr/lib/ruby/gems/1.8/gems/rvm-1.9.2/lib/rvm/shell/shell_wrapper.sh'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [export rvm_path='/usr/local/rvm'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [source '/usr/local/rvm/scripts/rvm'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [rvm 'use' 'default'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:35 +0000] DEBUG: RVM::Shell::ChefWrapper executing: [rvm 'list' 'strings'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:36 +0000] INFO: Processing rvm_gem[bundler] action install (/var/cache/chef/cookbooks/rvm/providers/global_gem.rb line 76)
[Mon, 31 Oct 2011 22:26:36 +0000] DEBUG: sh(bash -c "source /etc/profile.d/rvm.sh && rvm ruby-1.9.2-p290@global do gem env gempath")
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: rvm_gem[bundler] found installed gem bundler version 1.0.21 matching bundler (>= 0, runtime)
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: rvm_gem[bundler] is already installed - nothing to do
[Mon, 31 Oct 2011 22:26:38 +0000] INFO: Processing execute[Add bundler to /usr/local/rvm/gemsets/global.gems] action nothing (/var/cache/chef/cookbooks/rvm/providers/global_gem.rb line 102)
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: Executing grep -q "^bundler" "/usr/local/rvm/gemsets/global.gems"
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: ---- Begin output of grep -q "^bundler" "/usr/local/rvm/gemsets/global.gems" ----
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: STDOUT:
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: STDERR:
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: ---- End output of grep -q "^bundler" "/usr/local/rvm/gemsets/global.gems" ----
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: Ran grep -q "^bundler" "/usr/local/rvm/gemsets/global.gems" returned 0
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: Skipping execute[Add bundler to /usr/local/rvm/gemsets/global.gems] due to not_if
[Mon, 31 Oct 2011 22:26:38 +0000] INFO: Processing rvm_gem[bundler] action nothing (/var/cache/chef/cookbooks/rvm/providers/global_gem.rb line 76)
[Mon, 31 Oct 2011 22:26:38 +0000] DEBUG: sh(bash -c "source /etc/profile.d/rvm.sh && rvm ruby-1.9.2-p290@global do gem env gempath")
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: rvm_gem[bundler] found installed gem bundler version 1.0.21 matching bundler (>= 0, runtime)
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: Doing nothing for rvm_gem[bundler]
[Mon, 31 Oct 2011 22:26:40 +0000] INFO: Processing rvm_global_gem[rake] action install (rvm::system line 36)
[Mon, 31 Oct 2011 22:26:40 +0000] INFO: Processing execute[Add rake to /usr/local/rvm/gemsets/global.gems] action run (/var/cache/chef/cookbooks/rvm/providers/global_gem.rb line 102)
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: Executing grep -q "^rake" "/usr/local/rvm/gemsets/global.gems"
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: ---- Begin output of grep -q "^rake" "/usr/local/rvm/gemsets/global.gems" ----
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: STDOUT:
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: STDERR:
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: ---- End output of grep -q "^rake" "/usr/local/rvm/gemsets/global.gems" ----
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: Ran grep -q "^rake" "/usr/local/rvm/gemsets/global.gems" returned 0
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: Skipping execute[Add rake to /usr/local/rvm/gemsets/global.gems] due to not_if
[Mon, 31 Oct 2011 22:26:40 +0000] DEBUG: RVM::Shell::ChefWrapper subprocess executing with environment of: [{}].
[Mon, 31 Oct 2011 22:26:41 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [source '/usr/lib/ruby/gems/1.8/gems/rvm-1.9.2/lib/rvm/shell/shell_wrapper.sh'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:41 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [export rvm_path='/usr/local/rvm'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:41 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [source '/usr/local/rvm/scripts/rvm'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:41 +0000] DEBUG: RVM::Shell::ChefWrapper silently executing: [rvm 'use' 'default'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:41 +0000] DEBUG: RVM::Shell::ChefWrapper executing: [rvm 'list' 'strings'; __rvm_show_command_epilog]
[Mon, 31 Oct 2011 22:26:42 +0000] INFO: Processing rvm_gem[rake] action install (/var/cache/chef/cookbooks/rvm/providers/global_gem.rb line 76)
[Mon, 31 Oct 2011 22:26:42 +0000] DEBUG: sh(bash -c "source /etc/profile.d/rvm.sh && rvm ruby-1.9.2-p290@global do gem env gempath")
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: rvm_gem[rake] found installed gem rake version 0.9.2 matching rake (= 0.9.2, runtime)
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: rvm_gem[rake] is already installed - nothing to do
[Mon, 31 Oct 2011 22:26:44 +0000] INFO: Processing execute[Add rake to /usr/local/rvm/gemsets/global.gems] action nothing (/var/cache/chef/cookbooks/rvm/providers/global_gem.rb line 102)
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: Executing grep -q "^rake" "/usr/local/rvm/gemsets/global.gems"
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: ---- Begin output of grep -q "^rake" "/usr/local/rvm/gemsets/global.gems" ----
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: STDOUT:
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: STDERR:
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: ---- End output of grep -q "^rake" "/usr/local/rvm/gemsets/global.gems" ----
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: Ran grep -q "^rake" "/usr/local/rvm/gemsets/global.gems" returned 0
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: Skipping execute[Add rake to /usr/local/rvm/gemsets/global.gems] due to not_if
[Mon, 31 Oct 2011 22:26:44 +0000] INFO: Processing rvm_gem[rake] action nothing (/var/cache/chef/cookbooks/rvm/providers/global_gem.rb line 76)
[Mon, 31 Oct 2011 22:26:44 +0000] DEBUG: sh(bash -c "source /etc/profile.d/rvm.sh && rvm ruby-1.9.2-p290@global do gem env gempath")
[Mon, 31 Oct 2011 22:26:46 +0000] DEBUG: rvm_gem[rake] found installed gem rake version 0.9.2 matching rake (= 0.9.2, runtime)
[Mon, 31 Oct 2011 22:26:46 +0000] DEBUG: Doing nothing for rvm_gem[rake]
[Mon, 31 Oct 2011 22:26:46 +0000] INFO: Processing rvm_default_ruby[ruby-1.9.2-p290@chef-rundeck] action create (rundeck::chef line 21)
[Mon, 31 Oct 2011 22:26:46 +0000] DEBUG: Fetching canonical RVM string for: ruby-1.9.2-p290 (rundeck)
[Mon, 31 Oct 2011 22:26:46 +0000] ERROR: rvm_default_ruby[ruby-1.9.2-p290@chef-rundeck] (rundeck::chef line 21) has had an error
[Mon, 31 Oct 2011 22:26:46 +0000] ERROR: Running exception handlers
[Mon, 31 Oct 2011 22:26:47 +0000] FATAL: Saving node information to /var/cache/chef/failed-run-data.json
[Mon, 31 Oct 2011 22:26:47 +0000] ERROR: Exception handlers complete
[Mon, 31 Oct 2011 22:26:47 +0000] DEBUG: Re-raising exception: NoMethodError - rvm_default_ruby[ruby-1.9.2-p290@chef-rundeck] (rundeck::chef line 21) had an error: private method `chomp' called for nil:NilClass
/var/cache/chef/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:77:in `canonical_ruby_string'
/var/cache/chef/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:50:in `fetch'
/var/cache/chef/cookbooks/rvm/libraries/chef_rvm_string_helpers.rb:55:in `normalize_ruby_string'
/var/cache/chef/cookbooks/rvm/providers/default_ruby.rb:26:in `load_current_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource.rb:416:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:45:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:78:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:78:in `each'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:78:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection.rb:94:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:76:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/client.rb:312:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/client.rb:160:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/application/client.rb:239:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/application/client.rb:229:in `loop'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/application/client.rb:229:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/application.rb:66:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/chef-client:26
/usr/bin/chef-client:19:in `load'
/usr/bin/chef-client:19
[Mon, 31 Oct 2011 22:26:47 +0000] ERROR: NoMethodError: rvm_default_ruby[ruby-1.9.2-p290@chef-rundeck] (rundeck::chef line 21) had an error: private method `chomp' called for nil:NilClass
[Mon, 31 Oct 2011 22:26:47 +0000] FATAL: Stacktrace dumped to /var/cache/chef/chef-stacktrace.out
[Mon, 31 Oct 2011 22:26:47 +0000] DEBUG: NoMethodError: rvm_default_ruby[ruby-1.9.2-p290@chef-rundeck] (rundeck::chef line 21) had an error: private method `chomp' called for nil:NilClass
/var/cache/chef/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:77:in `canonical_ruby_string'
/var/cache/chef/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:50:in `fetch'
/var/cache/chef/cookbooks/rvm/libraries/chef_rvm_string_helpers.rb:55:in `normalize_ruby_string'
/var/cache/chef/cookbooks/rvm/providers/default_ruby.rb:26:in `load_current_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource.rb:416:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:45:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:78:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:78:in `each'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:78:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection.rb:94:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/runner.rb:76:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/client.rb:312:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/client.rb:160:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/application/client.rb:239:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/application/client.rb:229:in `loop'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/application/client.rb:229:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/../lib/chef/application.rb:66:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.2/bin/chef-client:26
/usr/bin/chef-client:19:in `load'
/usr/bin/chef-client:19
[Mon, 31 Oct 2011 22:26:47 +0000] ERROR: Sleeping for 1800 seconds before trying again