Deployment failed Deployment has failed. Method granular_deploy. Failed to execute hook

Bug #1450958 reported by Craig Peters
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
Fuel for OpenStack
Confirmed
High
Fuel Library (Deprecated)

Bug Description

Deployment of 6.1 for Ubuntu using image based provisioning fails when deploying cinder.

Error message in Fuel UI
Deployment has failed. Method granular_deploy. Failed to execute hook .
---
priority: 500
fail_on_error: true
type: puppet
uids:
- '5'
- '4'
parameters:
  puppet_modules: "/etc/puppet/modules"
  puppet_manifest: "/etc/puppet/modules/osnailyfacter/modular/astute/enable_cinder.pp"
  timeout: 3600
  cwd: "/"
.
Inspect Astute logs for the details

Puppet log:
2015-05-01 22:11:06 NOTICE
 Finished catalog run in 0.08 seconds
2015-05-01 22:11:05 INFO
 (Stage[main]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (Stage[main]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (Class[Main]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (Class[Main]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (/Schedule[puppet]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (/Schedule[puppet]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (/Schedule[weekly]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (/Schedule[weekly]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (/Filebucket[puppet]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (/Filebucket[puppet]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (/Schedule[never]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (/Schedule[never]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (Class[Cinder::Params]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (Class[Cinder::Params]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (/Stage[main]/Main/Service[cinder-volume]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/bin/puppet:4:in `<main>'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/util/command_line.rb:91:in `execute'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/util/command_line.rb:137:in `run'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/application.rb:364:in `run'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/util.rb:478:in `exit_on_fail'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/application.rb:364:in `block in run'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/application.rb:470:in `plugin_hook'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/application.rb:364:in `block (2 levels) in run'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/application/apply.rb:146:in `run_command'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/application/apply.rb:218:in `main'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/application/apply.rb:268:in `apply_catalog'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/configurer.rb:192:in `run'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/configurer.rb:124:in `apply_catalog'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/util.rb:160:in `benchmark'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/1.9.1/benchmark.rb:295:in `realtime'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/util.rb:161:in `block in benchmark'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/configurer.rb:125:in `block in apply_catalog'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/resource/catalog.rb:163:in `apply'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/transaction/report.rb:108:in `as_logging_destination'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/util/log.rb:149:in `with_destination'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/resource/catalog.rb:164:in `block in apply'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/transaction.rb:108:in `evaluate'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/graph/relationship_graph.rb:118:in `traverse'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/transaction.rb:117:in `block in evaluate'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/util.rb:326:in `thinmark'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/1.9.1/benchmark.rb:295:in `realtime'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/util.rb:327:in `block in thinmark'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/transaction.rb:117:in `block (2 levels) in evaluate'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/transaction.rb:117:in `call'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/transaction.rb:187:in `eval_resource'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/transaction.rb:174:in `apply'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/transaction/resource_harness.rb:19:in `evaluate'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/transaction/resource_harness.rb:223:in `from_resource'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/type.rb:1063:in `retrieve_resource'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/type.rb:1035:in `retrieve'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/type/service.rb:85:in `retrieve'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/provider/service/upstart.rb:139:in `status'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/provider/service/upstart.rb:150:in `is_upstart?'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/provider/service/init.rb:94:in `initscript'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) /usr/lib/ruby/vendor_ruby/puppet/provider/service/upstart.rb:82:in `search'
2015-05-01 22:11:05 ERR
 (/Stage[main]/Main/Service[cinder-volume]) Could not evaluate: Could not find init script or upstart conf file for 'cinder-volume'
2015-05-01 22:11:05 INFO
 (/Stage[main]/Main/Service[cinder-volume]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (Class[Settings]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (Class[Settings]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (Class[Settings]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (Class[Settings]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (Class[Cinder::Params]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (Class[Cinder::Params]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (Class[Main]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (Class[Main]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (Stage[main]) Evaluated in 0.02 seconds
2015-05-01 22:11:05 INFO
 (Stage[main]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (/Schedule[hourly]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (/Schedule[hourly]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (/Schedule[monthly]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (/Schedule[monthly]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 (/Schedule[daily]) Evaluated in 0.00 seconds
2015-05-01 22:11:05 INFO
 (/Schedule[daily]) Starting to evaluate the resource
2015-05-01 22:11:05 INFO
 Applying configuration version '1430518248'
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/ceph/lib/facter/ceph_conf.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/ceph/lib/facter/cinder_conf.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/ceph/lib/facter/ceph_osd.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/ceph/lib/facter/keystone_conf.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/ceph/lib/facter/glance_api_conf.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/ceph/lib/facter/nova_compute.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/osnailyfacter/lib/facter/naily.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/osnailyfacter/lib/facter/fuel_pkgs_exist.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/galera/lib/facter/galera_gcomm_empty.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/galera/lib/facter/mysql_log_file_size_real.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/l23network/lib/facter/fqdn_hostname.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/l23network/lib/facter/ovs_vlan_splinters.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/l23network/lib/facter/openvswitch.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/l23network/lib/facter/default_route.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/l23network/lib/facter/check_kern_module.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/l23network/lib/facter/l23_os.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/firewall/lib/facter/iptables_version.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/firewall/lib/facter/iptables_persistent_version.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/firewall/lib/facter/ip6tables_version.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/nailgun/lib/facter/iops.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/nailgun/lib/facter/fuel_version.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/nailgun/lib/facter/generate_fuel_key.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/stdlib/lib/facter/facter_dot_d.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/stdlib/lib/facter/pe_version.rb
2015-05-01 22:10:49 INFO
 Loading facts in /etc/puppet/modules/stdlib/lib/facter/puppet_vardir.rb

Revision history for this message
Craig Peters (craig-l-peters) wrote :
Revision history for this message
Nastya Urlapova (aurlapova) wrote :

Craig, did you use vbox or kvm, mac os or ubuntu?

Changed in fuel:
milestone: none → 6.1
assignee: nobody → Fuel Library Team (fuel-library)
status: New → Incomplete
status: Incomplete → New
Changed in fuel:
importance: Undecided → High
Revision history for this message
Craig Peters (craig-l-peters) wrote :

I am using a machine using ESXi to simulate hardware nodes.

Changed in fuel:
status: New → Confirmed
Revision history for this message
Vladimir Kuklin (vkuklin) wrote :

Craig, it seems you experienced to bugs:

1) keystone token validation issue: https://bugs.launchpad.net/fuel/+bug/1451515
2) apt-get IPv6 issue: https://bugs.launchpad.net/fuel/+bug/1446227 (fix merged) which is the main reason of package installation failure

According to your diag snapshot, you are using the code where #2 is not yet fixed. Please, download new ISO and try again.

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.