katello-nightly-rpm-pipeline 816 failed

jenkins · March 11, 2019, 10:50pm

Katello nightly pipeline failed:

https://ci.theforeman.org/job/katello-nightly-rpm-pipeline/816/

tbrisker · March 12, 2019, 7:51am

Looks like proxy is failing to load:

[ INFO 2019-03-11T22:26:09 verbose]  Class[Foreman_proxy::Register]: Scheduling refresh of Foreman_smartproxy[pipeline-katello-nightly-centos7.n40.example.com]
[ERROR 2019-03-11T22:26:11 verbose]  Proxy pipeline-katello-nightly-centos7.n40.example.com has failed to load one or more features (HTTPBoot, Puppet, Puppet CA, TFTP, Templates, Logs), check /var/log/foreman-proxy/proxy.log for configuration errors
[ERROR 2019-03-11T22:26:11 verbose] /usr/share/foreman-installer/modules/foreman/lib/puppet/provider/foreman_smartproxy/rest_v3.rb:70:in `validate_features!'
[ERROR 2019-03-11T22:26:11 verbose] /usr/share/foreman-installer/modules/foreman/lib/puppet/provider/foreman_smartproxy/rest_v3.rb:24:in `create'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/property/ensure.rb:16:in `block in defaultvalues'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/property.rb:491:in `set'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/property.rb:568:in `sync'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction/resource_harness.rb:238:in `sync'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction/resource_harness.rb:134:in `sync_if_needed'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction/resource_harness.rb:80:in `perform_changes'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction/resource_harness.rb:21:in `evaluate'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction.rb:259:in `apply'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction.rb:279:in `eval_resource'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction.rb:183:in `call'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction.rb:183:in `block (2 levels) in evaluate'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util.rb:519:in `block in thinmark'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/2.4.0/benchmark.rb:308:in `realtime'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util.rb:518:in `thinmark'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction.rb:183:in `block in evaluate'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/graph/relationship_graph.rb:121:in `traverse'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction.rb:173:in `evaluate'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/resource/catalog.rb:239:in `block (2 levels) in apply'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util.rb:519:in `block in thinmark'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/2.4.0/benchmark.rb:308:in `realtime'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util.rb:518:in `thinmark'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/resource/catalog.rb:238:in `block in apply'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util/log.rb:156:in `with_destination'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/transaction/report.rb:146:in `as_logging_destination'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/resource/catalog.rb:237:in `apply'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/configurer.rb:186:in `block (2 levels) in apply_catalog'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util.rb:519:in `block in thinmark'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/2.4.0/benchmark.rb:308:in `realtime'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util.rb:518:in `thinmark'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/configurer.rb:185:in `block in apply_catalog'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util.rb:232:in `block in benchmark'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/2.4.0/benchmark.rb:308:in `realtime'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util.rb:231:in `benchmark'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/configurer.rb:184:in `apply_catalog'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/configurer.rb:369:in `run_internal'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/configurer.rb:237:in `block in run'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/context.rb:65:in `override'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet.rb:260:in `override'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/configurer.rb:211:in `run'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/application/apply.rb:355:in `apply_catalog'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/application/apply.rb:280:in `block (2 levels) in main'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/context.rb:65:in `override'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet.rb:260:in `override'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/application/apply.rb:280:in `block in main'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/context.rb:65:in `override'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet.rb:260:in `override'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/application/apply.rb:233:in `main'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/application/apply.rb:174:in `run_command'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/application.rb:375:in `block in run'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util.rb:667:in `exit_on_fail'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/application.rb:375:in `run'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util/command_line.rb:135:in `run'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/lib/ruby/vendor_ruby/puppet/util/command_line.rb:73:in `execute'
[ERROR 2019-03-11T22:26:11 verbose] /opt/puppetlabs/puppet/bin/puppet:5:in `<main>'
[ERROR 2019-03-11T22:26:11 verbose]  /Stage[main]/Foreman_proxy::Register/Foreman_smartproxy[pipeline-katello-nightly-centos7.n40.example.com]/ensure: change from 'absent' to 'present' failed: Proxy pipeline-katello-nightly-centos7.n40.example.com has failed to load one or more features (HTTPBoot, Puppet, Puppet CA, TFTP, Templates, Logs), check /var/log/foreman-proxy/proxy.log for configuration errors

tbrisker · March 12, 2019, 8:00am

Looking in proxy.log, only error is:

 2019-03-11T22:26:09  [W] TCPServer Error: Address already in use - bind(2)

but it still seems to start successfully

tbrisker · March 12, 2019, 8:11am

Looking at the logs looks like all the calls for registering the proxy and refreshing features succeeded, not sure why the installer is saying that all the features didn’t load - maybe related to the new capabilities api? cc @Justin_Sherrill @ekohl

Justin_Sherrill · March 12, 2019, 7:16pm

Looking into this.

Justin

Justin_Sherrill · March 13, 2019, 2:24am

https://github.com/theforeman/foreman/pull/6565

On my reproducer this appeared to solve the issue

system · March 20, 2019, 2:24am

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.