search

chocolatey-archive / puppet-chocolatey

Chocolatey package provider
Apache License 2.0
87 stars 135 forks source link

Can't make it to work #146

Open tardich opened 7 years ago

tardich commented 7 years ago

Looks like a great puppet module. Unfortunately, despite all efforts I made, I can't make it to work. Updated the module to care about proxies (since I'm behind one), left all parameters to default (except for version which I set to 0.10.3), but I'm still getting this issue when trying to run:

Error: Could not retrieve catalog from remote server: Error 400 on SERVER: undefined method 'ref' for nil:NilClass on node

What do I do wrong?

ferventcoder commented 7 years ago

Perhaps a little more information? What does your manifest look like?

The error isn't one I've seen before, but that doesn't mean it isn't from this module.

So let's do this. Run the puppet agent or apply with debug, trace, and verbose and provide that output - e.g. puppet agent -t --trace --debug --verbose. That output will be more helpful in seeing where this error is occurring so we can pinpoint what needs to be done to fix the issue.

Second, what version of the module do you have installed? puppet module list will provide that information.

tardich commented 7 years ago

debug.txt

The attachment is the complete output of the puppet agent run with the parameters you requested.

About the manifest... well.... I'm managing my hosts through Foreman. So the only class included is chocolatey, and the only parameters set for the host are:

proxy_port: 3128 proxy_server: xxxxxxxxxxxxxx

Directly on the class, I have:

chocolatey_version: 0.10.3

Module version is 1.2.6

ferventcoder commented 7 years ago 
The system cannot find the path specified.
Using Facter::Util::Resolution.exec with a shell built-in is deprecated. Most built-ins can be replaced with native ruby commands. If you really have to run a built-in, pass "cmd /c your_builtin" as a command (command responsible for this message was "vgs -o name --noheadings 2>/dev/null")
The system cannot find the path specified.
Using Facter::Util::Resolution.exec with a shell built-in is deprecated. Most built-ins can be replaced with native ruby commands. If you really have to run a built-in, pass "cmd /c your_builtin" as a command (command responsible for this message was "pvs -o name --noheadings 2>/dev/null")

[..snip..]

Using Facter::Util::Resolution.exec with a shell built-in is deprecated. Most built-ins can be replaced with native ruby commands. If you really have to run a built-in, pass "cmd /c your_builtin" as a command (command responsible for this message was "sshd -V 2>&1")
Debug: Failed to load library 'msgpack' for feature 'msgpack'
Debug: Puppet::Network::Format[msgpack]: feature msgpack is missing
Debug: catalog supports formats: pson b64_zlib_yaml yaml dot raw
Error: Could not retrieve catalog from remote server: Error 400 on SERVER: undefined method `ref' for nil:NilClass on node [REDACTED]
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/indirector/rest.rb:194:in `is_http_200?'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/indirector/rest.rb:100:in `find'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/indirector/indirection.rb:201:in `find'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:259:in `block in retrieve_new_catalog'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util.rb:327:in `block in thinmark'
D:/Program Files (x86)/Puppet Labs/Puppet/sys/ruby/lib/ruby/1.9.1/benchmark.rb:295:in `realtime'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util.rb:326:in `thinmark'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:258:in `retrieve_new_catalog'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:69:in `retrieve_catalog'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:109:in `prepare_and_retrieve_catalog'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:175:in `run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:48:in `block (4 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent/locker.rb:20:in `lock'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:48:in `block (3 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:118:in `with_client'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:45:in `block (2 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:83:in `run_in_fork'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:44:in `block in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:179:in `call'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:179:in `controlled_run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:42:in `run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application/agent.rb:355:in `onetime'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application/agent.rb:321:in `run_command'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:372:in `block (3 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:479:in `plugin_hook'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:372:in `block (2 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util.rb:479:in `exit_on_fail'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:372:in `block in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/context.rb:51:in `override'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet.rb:233:in `override'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:362:in `run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util/command_line.rb:137:in `run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util/command_line.rb:91:in `execute'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/bin/puppet:4:in `<main>'
Warning: Not using cache on failed catalog
Error: Could not retrieve catalog; skipping run
ferventcoder commented 7 years ago

@tardich these errors are not related to chocolatey/chocolatey from what I can tell. There may be something that having the Chocolatey module exasperates for something else, but not being able to retrieve the catalog isn't a known issue with using the module. You may want to remove Chocolatey and other components until you find out what is causing the issue with retrieving the catalog from the server.

Try applying anything else besides Chocolatey to the server and see if you get the same error.

Also what version of Puppet are you using?

tardich commented 7 years ago

Below is the log I created by changing the host environment, which is now in development rather than production. This, in fact, removed the question regarding the error we were seeing, related to lvm (vgs, pvs) and ssh (sshd) as I have almost no modules in this environment. Still the same problem, though. Still now working.

If I remove chocolatey module from the list of modules for my host, I don't have any issue on the run. So, somewhere along the line, chocolatey seems to be involved directly in the issue. Something weird missing on the puppet agent side?

I have two server environmens on which I'm testing this:

Windows 2012R2/Puppet 3.8.7 Windows 2008R2/Puppet 3.5.1

Debug: Failed to load library 'syslog' for feature 'syslog'
Debug: Failed to load library 'selinux' for feature 'selinux'
Debug: Using settings: adding file resource 'confdir': 'File[C:/ProgramData/PuppetLabs/puppet/etc]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'vardir': 'File[C:/ProgramData/PuppetLabs/puppet/var]{:path=>"C:/ProgramData/PuppetLabs/puppet/var", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'logdir': 'File[C:/ProgramData/PuppetLabs/puppet/var/log]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/log", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'statedir': 'File[C:/ProgramData/PuppetLabs/puppet/var/state]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state", :mode=>"1755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'rundir': 'File[C:/ProgramData/PuppetLabs/puppet/var/run]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/run", :mode=>"755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'libdir': 'File[C:/ProgramData/PuppetLabs/puppet/var/lib]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/lib", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'certdir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs", :mode=>"755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'ssldir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl", :mode=>"771", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'publickeydir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys", :mode=>"755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'requestdir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certificate_requests]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/certificate_requests", :mode=>"755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'privatekeydir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'privatedir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/private", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'hostcert': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/bnhs06jb01.bellnhs.int.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/bnhs06jb01.bellnhs.int.pem", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'hostprivkey': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys/bnhs06jb01.bellnhs.int.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys/bnhs06jb01.bellnhs.int.pem", :mode=>"640", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'hostpubkey': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys/bnhs06jb01.bellnhs.int.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys/bnhs06jb01.bellnhs.int.pem", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'localcacert': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/ca.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/ca.pem", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'hostcrl': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/crl.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/crl.pem", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'statefile': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/state.yaml]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/state.yaml", :mode=>"660", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'clientyamldir': 'File[C:/ProgramData/PuppetLabs/puppet/var/client_yaml]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/client_yaml", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'client_datadir': 'File[C:/ProgramData/PuppetLabs/puppet/var/client_data]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/client_data", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'classfile': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/classes.txt]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/classes.txt", :mode=>"640", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'resourcefile': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/resources.txt]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/resources.txt", :mode=>"640", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'clientbucketdir': 'File[C:/ProgramData/PuppetLabs/puppet/var/clientbucket]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/clientbucket", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'lastrunfile': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/last_run_summary.yaml]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/last_run_summary.yaml", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'lastrunreport': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/last_run_report.yaml]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/last_run_report.yaml", :mode=>"640", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'graphdir': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/graphs]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/graphs", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'pluginfactdest': 'File[C:/ProgramData/PuppetLabs/puppet/var/facts.d]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/facts.d", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Puppet::Type::File::ProviderPosix: feature posix is missing
Debug: Failed to load library 'shadow' for feature 'libshadow'
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/log]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/state]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/run]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/lib]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certificate_requests]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/bnhs06jb01.bellnhs.int.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys/bnhs06jb01.bellnhs.int.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys/bnhs06jb01.bellnhs.int.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/ca.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/crl.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/state/state.yaml]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var/state]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/client_yaml]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/client_data]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/state/classes.txt]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var/state]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/state/resources.txt]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var/state]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/clientbucket]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/state/last_run_summary.yaml]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var/state]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/state/last_run_report.yaml]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var/state]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/state/graphs]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var/state]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/facts.d]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: Finishing transaction 24371892
Debug: Using settings: adding file resource 'confdir': 'File[C:/ProgramData/PuppetLabs/puppet/etc]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'vardir': 'File[C:/ProgramData/PuppetLabs/puppet/var]{:path=>"C:/ProgramData/PuppetLabs/puppet/var", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'logdir': 'File[C:/ProgramData/PuppetLabs/puppet/var/log]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/log", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'statedir': 'File[C:/ProgramData/PuppetLabs/puppet/var/state]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state", :mode=>"1755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'rundir': 'File[C:/ProgramData/PuppetLabs/puppet/var/run]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/run", :mode=>"755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'libdir': 'File[C:/ProgramData/PuppetLabs/puppet/var/lib]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/lib", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'certdir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs", :mode=>"755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'ssldir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl", :mode=>"771", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'publickeydir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys", :mode=>"755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'requestdir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certificate_requests]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/certificate_requests", :mode=>"755", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'privatekeydir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'privatedir': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/private", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'hostcert': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/bnhs06jb01.bellnhs.int.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/bnhs06jb01.bellnhs.int.pem", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'hostprivkey': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys/bnhs06jb01.bellnhs.int.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys/bnhs06jb01.bellnhs.int.pem", :mode=>"640", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'hostpubkey': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys/bnhs06jb01.bellnhs.int.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys/bnhs06jb01.bellnhs.int.pem", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'localcacert': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/ca.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/ca.pem", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'hostcrl': 'File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/crl.pem]{:path=>"C:/ProgramData/PuppetLabs/puppet/etc/ssl/crl.pem", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'pluginfactdest': 'File[C:/ProgramData/PuppetLabs/puppet/var/facts.d]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/facts.d", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/log]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/state]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/run]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/lib]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certificate_requests]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/bnhs06jb01.bellnhs.int.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys/bnhs06jb01.bellnhs.int.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/private_keys]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys/bnhs06jb01.bellnhs.int.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/public_keys]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs/ca.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/certs]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/etc/ssl/crl.pem]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/etc/ssl]
Debug: /File[C:/ProgramData/PuppetLabs/puppet/var/facts.d]: Autorequiring File[C:/ProgramData/PuppetLabs/puppet/var]
Debug: Finishing transaction 36824448
Debug: Using cached certificate for ca
Debug: Using cached certificate for bnhs06jb01.bellnhs.int
Debug: Using settings: adding file resource 'statefile': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/state.yaml]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/state.yaml", :mode=>"660", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'clientyamldir': 'File[C:/ProgramData/PuppetLabs/puppet/var/client_yaml]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/client_yaml", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'client_datadir': 'File[C:/ProgramData/PuppetLabs/puppet/var/client_data]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/client_data", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'classfile': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/classes.txt]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/classes.txt", :mode=>"640", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'resourcefile': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/resources.txt]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/resources.txt", :mode=>"640", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'clientbucketdir': 'File[C:/ProgramData/PuppetLabs/puppet/var/clientbucket]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/clientbucket", :mode=>"750", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'lastrunfile': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/last_run_summary.yaml]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/last_run_summary.yaml", :mode=>"644", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'lastrunreport': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/last_run_report.yaml]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/last_run_report.yaml", :mode=>"640", :ensure=>:file, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Using settings: adding file resource 'graphdir': 'File[C:/ProgramData/PuppetLabs/puppet/var/state/graphs]{:path=>"C:/ProgramData/PuppetLabs/puppet/var/state/graphs", :ensure=>:directory, :loglevel=>:debug, :links=>:follow, :backup=>false}'
Debug: Finishing transaction 37422696
Debug: Loaded state in 0.05 seconds
Debug: Failed to load library 'msgpack' for feature 'msgpack'
Debug: Puppet::Network::Format[msgpack]: feature msgpack is missing
Debug: node supports formats: pson b64_zlib_yaml yaml raw
Debug: Using cached certificate for ca
Debug: Using cached certificate for bnhs06jb01.bellnhs.int
Debug: Using cached certificate_revocation_list for ca
Info: Retrieving plugin
Debug: Failed to load library 'msgpack' for feature 'msgpack'
Debug: Puppet::Network::Format[msgpack]: feature msgpack is missing
Debug: file_metadata supports formats: pson b64_zlib_yaml yaml raw
Debug: Finishing transaction 24250428
Info: Loading facts in C:/ProgramData/PuppetLabs/puppet/var/lib/facter/chocolateyversion.rb
Info: Loading facts in C:/ProgramData/PuppetLabs/puppet/var/lib/facter/choco_install_path.rb
Debug: Failed to load library 'msgpack' for feature 'msgpack'
Debug: Puppet::Network::Format[msgpack]: feature msgpack is missing
Debug: catalog supports formats: pson b64_zlib_yaml yaml dot raw
Error: Could not retrieve catalog from remote server: Error 400 on SERVER: undefined method `ref' for nil:NilClass on node [REDACTED]
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/indirector/rest.rb:194:in `is_http_200?'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/indirector/rest.rb:100:in `find'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/indirector/indirection.rb:201:in `find'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:259:in `block in retrieve_new_catalog'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util.rb:327:in `block in thinmark'
D:/Program Files (x86)/Puppet Labs/Puppet/sys/ruby/lib/ruby/1.9.1/benchmark.rb:295:in `realtime'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util.rb:326:in `thinmark'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:258:in `retrieve_new_catalog'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:69:in `retrieve_catalog'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:109:in `prepare_and_retrieve_catalog'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/configurer.rb:175:in `run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:48:in `block (4 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent/locker.rb:20:in `lock'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:48:in `block (3 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:118:in `with_client'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:45:in `block (2 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:83:in `run_in_fork'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:44:in `block in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:179:in `call'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:179:in `controlled_run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/agent.rb:42:in `run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application/agent.rb:355:in `onetime'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application/agent.rb:321:in `run_command'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:372:in `block (3 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:479:in `plugin_hook'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:372:in `block (2 levels) in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util.rb:479:in `exit_on_fail'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:372:in `block in run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/context.rb:51:in `override'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet.rb:233:in `override'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/application.rb:362:in `run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util/command_line.rb:137:in `run'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/lib/puppet/util/command_line.rb:91:in `execute'
D:/Program Files (x86)/Puppet Labs/Puppet/puppet/bin/puppet:4:in `<main>'
Warning: Not using cache on failed catalog
Error: Could not retrieve catalog; skipping run
tardich commented 7 years ago

Just performed a successful install in the lab environment where the main difference is..... I have no proxy !!! Direct internet access there. chocolatey 1.2.6, puppet 3.8.7, Windows 2008R2.

So it really looks like it's not working with a proxy in front of the server, which is unfortunate, as all of my prod environment sits behind web proxies

ferventcoder commented 7 years ago

@tardich the good thing about Chocolatey is that you can host everything internally. It does seem like something about the Chocolatey module is influencing something within your Puppet run and removing its ability to work through the proxy.

ferventcoder commented 7 years ago

It does work with web proxies normally, maybe we could explore the proxy type that you are using to see if there is some incompatibility there?

ferventcoder commented 7 years ago

That way we can fix the problem once we identify what it is.