Puppet

‘Not working properly’ isn’t a very useful subject but I’m finding it hard to debug this issue anymore by myself. I’m on OSX 10.7.2 with Puppet 2.7.8 and Macports 2.0.3. Issue was present in 2.7.6 (source) as well and also with 2.6.4 (installed via Macports).

# test.pp
package { 'git' : 
    ensure => 'latest',
    provider => 'macports',
}

# sudo puppet apply test.pp -v
info: Applying configuration version '1323470601'
err: /Stage[main]//Package[git]/ensure: change from absent to latest failed: Could not update: undefined method `[]' for nil:NilClass at /private/etc/puppet/test.pp:4
notice: Finished catalog run in 0.79 seconds

Puppet will complain about “undefined method `[]‘ for nil:NilClass” for any package. Running with debug mode and trace enabled:

# sudo puppet apply test.pp -v -d --trace
Password:
debug: Puppet::Type::Package::ProviderUrpmi: file urpmi does not exist
debug: Puppet::Type::Package::ProviderDpkg: file /usr/bin/dpkg does not exist
debug: Puppet::Type::Package::ProviderUp2date: file /usr/sbin/up2date-nox does not exist
debug: Puppet::Type::Package::ProviderPortupgrade: file /usr/local/sbin/portupgrade does not exist
debug: Puppet::Type::Package::ProviderPkg: file /usr/bin/pkg does not exist
debug: Puppet::Type::Package::ProviderFreebsd: file /usr/sbin/pkg_info does not exist
debug: Puppet::Type::Package::ProviderSun: file /usr/bin/pkginfo does not exist
debug: Puppet::Type::Package::ProviderPacman: file /usr/bin/pacman does not exist
debug: Puppet::Type::Package::ProviderFink: file /sw/bin/fink does not exist
debug: Puppet::Type::Package::ProviderAptitude: file /usr/bin/aptitude does not exist
debug: Puppet::Type::Package::ProviderZypper: file /usr/bin/zypper does not exist
debug: Puppet::Type::Package::ProviderHpux: file /usr/sbin/swremove does not exist
debug: Puppet::Type::Package::ProviderAptrpm: file apt-get does not exist
debug: Puppet::Type::Package::ProviderSunfreeware: file pkg-get does not exist
debug: Puppet::Type::Package::ProviderNim: file /usr/sbin/nimclient does not exist
debug: Puppet::Type::Package::ProviderRug: file /usr/bin/rug does not exist
debug: Puppet::Type::Package::ProviderPortage: file /usr/bin/emerge does not exist
debug: Puppet::Type::Package::ProviderOpenbsd: file pkg_info does not exist
debug: Puppet::Type::Package::ProviderRpm: file rpm does not exist
debug: Puppet::Type::Package::ProviderApt: file /usr/bin/apt-get does not exist
debug: Puppet::Type::Package::ProviderYum: file rpm does not exist
debug: Puppet::Type::Package::ProviderPorts: file /usr/local/sbin/portupgrade does not exist
debug: Puppet::Type::Package::ProviderAix: file /usr/sbin/installp does not exist
debug: Creating default schedules
debug: Failed to load library 'selinux' for feature 'selinux'
debug: Failed to load library 'shadow' for feature 'libshadow'
debug: Failed to load library 'ldap' for feature 'ldap'
debug: Puppet::Type::User::ProviderLdap: feature ldap is missing
debug: Puppet::Type::User::ProviderPw: file pw does not exist
debug: Puppet::Type::User::ProviderUseradd: file chage does not exist
debug: Puppet::Type::User::ProviderUser_role_add: file roleadd does not exist
debug: Puppet::Type::User::ProviderDirectoryservice: Executing '/usr/bin/dscl -plist . -list /Users'
debug: Puppet::Type::User::ProviderDirectoryservice: Executing '/usr/bin/dscl -plist . -read /Users/puppet'
debug: /File[/etc/puppet/ssl/certs]: Autorequiring File[/etc/puppet/ssl]
debug: /File[/var/lib/puppet/state/graphs]: Autorequiring File[/var/lib/puppet/state]
debug: /File[/var/lib/puppet/state/state.yaml]: Autorequiring File[/var/lib/puppet/state]
debug: /File[/etc/puppet/ssl]: Autorequiring File[/etc/puppet]
debug: /File[/var/lib/puppet/clientbucket]: Autorequiring File[/var/lib/puppet]
debug: /File[/var/lib/puppet/facts]: Autorequiring File[/var/lib/puppet]
debug: /File[/var/lib/puppet/log]: Autorequiring File[/var/lib/puppet]
debug: /File[/etc/puppet/ssl/private]: Autorequiring File[/etc/puppet/ssl]
debug: /File[/var/lib/puppet/lib]: Autorequiring File[/var/lib/puppet]
debug: /File[/var/lib/puppet/client_yaml]: Autorequiring File[/var/lib/puppet]
debug: /File[/var/lib/puppet/state/last_run_summary.yaml]: Autorequiring File[/var/lib/puppet/state]
debug: /File[/var/lib/puppet/run]: Autorequiring File[/var/lib/puppet]
debug: /File[/var/lib/puppet/state]: Autorequiring File[/var/lib/puppet]
debug: /File[/var/lib/puppet/state/last_run_report.yaml]: Autorequiring File[/var/lib/puppet/state]
debug: /File[/etc/puppet/ssl/certificate_requests]: Autorequiring File[/etc/puppet/ssl]
debug: /File[/var/lib/puppet/client_data]: Autorequiring File[/var/lib/puppet]
debug: /File[/etc/puppet/ssl/public_keys]: Autorequiring File[/etc/puppet/ssl]
debug: /File[/etc/puppet/ssl/private_keys]: Autorequiring File[/etc/puppet/ssl]
debug: Finishing transaction 2221713900
debug: Loaded state in 0.01 seconds
debug: Loaded state in 0.01 seconds
info: Applying configuration version '1323470916'
debug: /Schedule[daily]: Skipping device resources because running on a host
debug: /Schedule[monthly]: Skipping device resources because running on a host
debug: /Schedule[hourly]: Skipping device resources because running on a host
debug: Prefetching macports resources for package
debug: Puppet::Type::Package::ProviderMacports: Executing '/opt/local/bin/port -q installed'
debug: Puppet::Type::Package::ProviderMacports: Executing '/opt/local/bin/port -q installed git'
debug: Puppet::Type::Package::ProviderMacports: Executing '/opt/local/bin/port -q installed git'
/opt/local/lib/ruby/site_ruby/1.8/puppet/parameter.rb:165:in `fail'
/opt/local/lib/ruby/site_ruby/1.8/puppet/type/package.rb:89:in `set_latest'
/opt/local/lib/ruby/site_ruby/1.8/puppet/property.rb:81:in `send'
/opt/local/lib/ruby/site_ruby/1.8/puppet/property.rb:81:in `call_valuemethod'
/opt/local/lib/ruby/site_ruby/1.8/puppet/property.rb:256:in `set'
/opt/local/lib/ruby/site_ruby/1.8/puppet/property.rb:310:in `sync'
/opt/local/lib/ruby/site_ruby/1.8/puppet/transaction/resource_harness.rb:114:in `apply_parameter'
/opt/local/lib/ruby/site_ruby/1.8/puppet/transaction/resource_harness.rb:56:in `perform_changes'
/opt/local/lib/ruby/site_ruby/1.8/puppet/transaction/resource_harness.rb:133:in `evaluate'
/opt/local/lib/ruby/site_ruby/1.8/puppet/transaction.rb:49:in `apply'
/opt/local/lib/ruby/site_ruby/1.8/puppet/transaction.rb:84:in `eval_resource'
/opt/local/lib/ruby/site_ruby/1.8/puppet/transaction.rb:103:in `evaluate'
/opt/local/lib/ruby/site_ruby/1.8/puppet/util.rb:476:in `thinmark'
/opt/local/lib/ruby/1.8/benchmark.rb:308:in `realtime'
/opt/local/lib/ruby/site_ruby/1.8/puppet/util.rb:475:in `thinmark'
/opt/local/lib/ruby/site_ruby/1.8/puppet/transaction.rb:103:in `evaluate'
/opt/local/lib/ruby/site_ruby/1.8/puppet/transaction.rb:380:in `traverse'
/opt/local/lib/ruby/site_ruby/1.8/puppet/transaction.rb:99:in `evaluate'
/opt/local/lib/ruby/site_ruby/1.8/puppet/resource/catalog.rb:141:in `apply'
/opt/local/lib/ruby/site_ruby/1.8/puppet/configurer.rb:121:in `retrieve_and_apply_catalog'
/opt/local/lib/ruby/site_ruby/1.8/puppet/util.rb:180:in `benchmark'
/opt/local/lib/ruby/1.8/benchmark.rb:308:in `realtime'
/opt/local/lib/ruby/site_ruby/1.8/puppet/util.rb:179:in `benchmark'
/opt/local/lib/ruby/site_ruby/1.8/puppet/configurer.rb:120:in `retrieve_and_apply_catalog'
/opt/local/lib/ruby/site_ruby/1.8/puppet/configurer.rb:151:in `run'
/opt/local/lib/ruby/site_ruby/1.8/puppet/application/apply.rb:215:in `main'
/opt/local/lib/ruby/site_ruby/1.8/puppet/application/apply.rb:135:in `run_command'
/opt/local/lib/ruby/site_ruby/1.8/puppet/application.rb:306:in `run'
/opt/local/lib/ruby/site_ruby/1.8/puppet/application.rb:410:in `hook'
/opt/local/lib/ruby/site_ruby/1.8/puppet/application.rb:306:in `run'
/opt/local/lib/ruby/site_ruby/1.8/puppet/application.rb:401:in `exit_on_fail'
/opt/local/lib/ruby/site_ruby/1.8/puppet/application.rb:306:in `run'
/opt/local/lib/ruby/site_ruby/1.8/puppet/util/command_line.rb:69:in `execute'
/opt/local/bin/puppet:4
err: /Stage[main]//Package[git]/ensure: change from absent to latest failed: Could not update: undefined method `[]' for nil:NilClass at /private/etc/puppet/test.pp:4
debug: /Schedule[never]: Skipping device resources because running on a host
debug: /Schedule[weekly]: Skipping device resources because running on a host
debug: /Schedule[puppet]: Skipping device resources because running on a host
debug: Finishing transaction 2220870220
debug: Storing state
debug: Stored state in 0.04 seconds
notice: Finished catalog run in 0.85 seconds
debug: Finishing transaction 2221816080
debug: Received report to process from cbm.local
debug: Processing report from cbm.local with processor Puppet::Reports::Store