747048 – import f16 ami fails w/ malformed format string error

Bug 747048 - import f16 ami fails w/ malformed format string error

Summary: import f16 ami fails w/ malformed format string error

Keywords:
Status:	CLOSED ERRATA
Alias:	None
Product:	CloudForms Cloud Engine
Classification:	Retired
Component:	aeolus-conductor
Sub Component:
Version:	1.0.0
Hardware:	Unspecified
OS:	Unspecified
Priority:	unspecified
Severity:	medium
Target Milestone:	rc
Assignee:	Michal Fojtik
QA Contact:	Ronelle Landy
Docs Contact:
URL:	https://hp-bl480c-01.rhts.eng.bos.red...
Whiteboard:
Duplicates (1):	747254 (view as bug list)
Depends On:
Blocks:
TreeView+	depends on / blocked

Reported:	2011-10-18 16:49 UTC by wes hayutin
Modified:	2012-05-15 21:11 UTC (History)
CC List:	12 users (show)
Fixed In Version:	r1227194
Doc Type:	Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed:	2012-05-15 21:11:54 UTC

Attachments	(Terms of Use)
ss (122.74 KB, image/png) 2011-10-18 16:49 UTC, wes hayutin	no flags	Details
Error message after deltacloud patch (20.28 KB, image/png) 2012-01-19 16:27 UTC, Petr Blaho	no flags	Details
import (242.92 KB, image/png) 2012-02-16 09:30 UTC, Shveta	no flags	Details
View All Add an attachment (proposed patch, testcase, etc.)

Links
System	ID	Private	Priority	Status	Summary	Last Updated
Red Hat Product Errata	RHEA-2012:0583	0	normal	SHIPPED_LIVE	new packages: aeolus-conductor	2012-05-15 22:31:59 UTC

Description wes hayutin 2011-10-18 16:49:09 UTC

Created attachment 528848 [details]
ss

Description of problem:

not sure how supported this is... but opening a bug report to get some other eyes on it.

I'm importing f16 "ami-2f69a446"



RAILS LOG

pZIUWIPslmtLhBCfH9ECgYAwWzHMaVODVXiKKhchlMS2AulkvexyYLiI4IlJFF+Uj7RDZYsk
PtdnOCaGWWdXyCMYG5JLtH2GqeZ99Z3VBDj++j3ARGzMkn1T8WLvbQdkJcbmpD2eLQjD+T9LtH7d
cnZEBmTrFPdJ8jUHd6ON3wnvWHO2Jpog2jm7exG7H5bbuQKBgQDfIxE51sz7mQ62cYE4/E8+U3e0
hwVRaRyQicx95XH9LknnZrTXMivF25QIyA039I50B5QaqU2C86jCytRPD0sTRPJA0zhC24HieDsm
4VMI1i02dBQTj8oO7x8QvcBORajRATzEKgdwufHH30Ee83DeyJRvCZw+yBVSk5urPdUqGg==
-----END RSA PRIVATE KEY-----
', '2011-10-18 16:37:36.400782') RETURNING "id"
  SQL (6.1ms)  COMMIT
  InstanceKey Load (0.5ms)  SELECT "instance_keys".* FROM "instance_keys" WHERE ("instance_keys".instance_id = 4) LIMIT 1
  SQL (0.2ms)  BEGIN
  SQL (0.4ms)  COMMIT
  SQL (0.2ms)  BEGIN
  SQL (0.6ms)  SELECT 1 FROM "instances" WHERE "instances"."pool_id" = 1 AND ("instances"."name" = 'asdf/ami-2f69a446') AND ("instances".id <> 4) LIMIT 1
  AREL (0.7ms)  UPDATE "instances" SET "lock_version" = 1, "provider_account_id" = 6, "updated_at" = '2011-10-18 16:37:36.427763' WHERE ("instances"."id" = 4 AND "instances"."lock_version" = 0)
  SQL (1.8ms)  COMMIT
malformed format string - %A
/usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:403:in `handle_backend_error'
/usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:361:in `request'
/usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:218:in `call'
/usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:218:in `process_result'
/usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:169:in `transmit'
/usr/lib/ruby/1.8/net/http.rb:543:in `start'
/usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:166:in `transmit'
/usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:60:in `execute'
/usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:31:in `execute'
/usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/resource.rb:63:in `post'
/usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:360:in `send'
/usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:360:in `request'
/usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:306:in `method_missing'
/usr/share/aeolus-conductor/app/util/taskomatic.rb:153:in `create_dcloud_instance'
/usr/share/aeolus-conductor/app/util/taskomatic.rb:32:in `create_instance'
/usr/share/aeolus-conductor/app/models/deployment.rb:252:in `launch'
/usr/share/aeolus-conductor/app/models/deployment.rb:239:in `each'
/usr/share/aeolus-conductor/app/models/deployment.rb:239:in `launch'
/usr/share/aeolus-conductor/app/controllers/deployments_controller.rb:95:in `create'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/mime_responds.rb:264:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/mime_responds.rb:264:in `retrieve_response_from_mimes'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/mime_responds.rb:191:in `respond_to'
/usr/share/aeolus-conductor/app/controllers/deployments_controller.rb:93:in `create'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/implicit_render.rb:4:in `send_action'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/implicit_render.rb:4:in `send_action'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/base.rb:150:in `process_action'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/rendering.rb:11:in `process_action'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/callbacks.rb:18:in `process_action'
/usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:441:in `_run__1359547276__process_action__1623385099__callbacks'
/usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:410:in `send'
/usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:410:in `_run_process_action_callbacks'
/usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:94:in `send'
/usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:94:in `run_callbacks'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/callbacks.rb:17:in `process_action'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/rescue.rb:17:in `process_action'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/instrumentation.rb:30:in `process_action'
/usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/notifications.rb:52:in `instrument'
/usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/notifications/instrumenter.rb:21:in `instrument'
/usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/notifications.rb:52:in `instrument'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/instrumentation.rb:29:in `process_action'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/base.rb:119:in `process'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/rendering.rb:41:in `process'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal.rb:138:in `dispatch'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal.rb:178:in `action'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/routing/route_set.rb:62:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/routing/route_set.rb:62:in `dispatch'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/routing/route_set.rb:27:in `call'
/usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/route_set.rb:150:in `call'
/usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/code_generation.rb:93:in `recognize'
/usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/code_generation.rb:75:in `optimized_each'
/usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/code_generation.rb:92:in `recognize'
/usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/route_set.rb:141:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/routing/route_set.rb:493:in `call'
/usr/lib/ruby/gems/1.8/gems/warden-1.0.3/lib/warden/manager.rb:35:in `call'
/usr/lib/ruby/gems/1.8/gems/warden-1.0.3/lib/warden/manager.rb:34:in `catch'
/usr/lib/ruby/gems/1.8/gems/warden-1.0.3/lib/warden/manager.rb:34:in `call'
/usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/methodoverride.rb:24:in `call'
/usr/lib/ruby/gems/1.8/gems/rack-restful_submit-1.2.1/lib/rack/rack-restful_submit.rb:25:in `call'
/usr/lib/ruby/gems/1.8/gems/sass-3.1.4/lib/sass/../sass/plugin/rack.rb:54:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/head.rb:14:in `call'
/usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/methodoverride.rb:24:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/params_parser.rb:21:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/flash.rb:182:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/session/abstract_store.rb:149:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/cookies.rb:302:in `call'
/usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/query_cache.rb:32:in `call'
/usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/connection_adapters/abstract/query_cache.rb:28:in `cache'
/usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/query_cache.rb:12:in `cache'
/usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/query_cache.rb:31:in `call'
/usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/connection_adapters/abstract/connection_pool.rb:354:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/callbacks.rb:46:in `call'
/usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:416:in `_run_call_callbacks'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/callbacks.rb:44:in `call'
/usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/sendfile.rb:102:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/remote_ip.rb:48:in `call'
/usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/show_exceptions.rb:47:in `call'
/usr/lib/ruby/gems/1.8/gems/railties-3.0.10/lib/rails/rack/logger.rb:13:in `call'
/usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/runtime.rb:17:in `call'
/usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/lock.rb:34:in `call'
/usr/lib/ruby/gems/1.8/gems/railties-3.0.10/lib/rails/application.rb:168:in `call'
/usr/lib/ruby/gems/1.8/gems/railties-3.0.10/lib/rails/application.rb:77:in `send'
/usr/lib/ruby/gems/1.8/gems/railties-3.0.10/lib/rails/application.rb:77:in `method_missing'
/usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/urlmap.rb:52:in `call'
/usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/urlmap.rb:46:in `each'
/usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/urlmap.rb:46:in `call'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:84:in `pre_process'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:82:in `catch'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:82:in `pre_process'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:57:in `process'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:42:in `receive_data'
/usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:256:in `run_machine'
/usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:256:in `run'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/backends/base.rb:61:in `start'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/server.rb:159:in `start'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/controllers/controller.rb:86:in `start'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/runner.rb:185:in `send'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/runner.rb:185:in `run_command'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/runner.rb:151:in `run!'
/usr/lib/ruby/gems/1.8/gems/thin-1.2.11/bin/thin:6
/usr/bin/thin:19:in `load'
/usr/bin/thin:19
  SQL (0.2ms)  BEGIN
  SQL (0.5ms)  SELECT 1 FROM "instances" WHERE "instances"."pool_id" = 1 AND ("instances"."name" = 'asdf/ami-2f69a446') AND ("instances".id <> 4) LIMIT 1
  Pool Load (0.5ms)  SELECT "pools".* FROM "pools" WHERE "pools"."id" = 1 LIMIT 1
  Quota Load (0.5ms)  SELECT "quotas".* FROM "quotas" WHERE "quotas"."id" = 2 LIMIT 1
  AREL (0.6ms)  UPDATE "instances" SET "lock_version" = 2, "updated_at" = '2011-10-18 16:37:36.942581', "state" = 'create_failed' WHERE ("instances"."id" = 4 AND "instances"."lock_version" = 1)
  SQL (0.5ms)  INSERT INTO "events" ("source_type", "status_code", "created_at", "source_id", "event_time", "description", "summary", "updated_at") VALUES ('Instance', NULL, '2011-10-18 16:37:36.948498', 4, '2011-10-18 16:37:36.000000', NULL, 'state changed to create_failed', '2011-10-18 16:37:36.948498') RETURNING "id"
  SQL (2.7ms)  COMMIT
  SQL (0.2ms)  BEGIN
  AREL (0.6ms)  UPDATE "tasks" SET "time_ended" = '2011-10-18 16:37:36.958569', "lock_version" = 2, "state" = 'failed' WHERE "tasks"."type" = 'InstanceTask' AND ("tasks"."id" = 4 AND "tasks"."lock_version" = 1)
  SQL (5.6ms)  COMMIT
malformed format string - %A
/usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:403:in `handle_backend_error'
    /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:361:in `request'
    /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:218:in `call'
    /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:218:in `process_result'
    /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:169:in `transmit'
    /usr/lib/ruby/1.8/net/http.rb:543:in `start'
    /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:166:in `transmit'
    /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:60:in `execute'
    /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:31:in `execute'
    /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/resource.rb:63:in `post'
    /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:360:in `send'
    /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:360:in `request'
    /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:306:in `method_missing'
    /usr/share/aeolus-conductor/app/util/taskomatic.rb:153:in `create_dcloud_instance'
    /usr/share/aeolus-conductor/app/util/taskomatic.rb:32:in `create_instance'
    /usr/share/aeolus-conductor/app/models/deployment.rb:252:in `launch'
    /usr/share/aeolus-conductor/app/models/deployment.rb:239:in `each'
    /usr/share/aeolus-conductor/app/models/deployment.rb:239:in `launch'
    /usr/share/aeolus-conductor/app/controllers/deployments_controller.rb:95:in `create'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/mime_responds.rb:264:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/mime_responds.rb:264:in `retrieve_response_from_mimes'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/mime_responds.rb:191:in `respond_to'
    /usr/share/aeolus-conductor/app/controllers/deployments_controller.rb:93:in `create'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/implicit_render.rb:4:in `send_action'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/implicit_render.rb:4:in `send_action'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/base.rb:150:in `process_action'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/rendering.rb:11:in `process_action'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/callbacks.rb:18:in `process_action'
    /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:441:in `_run__1359547276__process_action__1623385099__callbacks'
    /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:410:in `send'
    /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:410:in `_run_process_action_callbacks'
    /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:94:in `send'
    /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:94:in `run_callbacks'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/callbacks.rb:17:in `process_action'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/rescue.rb:17:in `process_action'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/instrumentation.rb:30:in `process_action'
    /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/notifications.rb:52:in `instrument'
    /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/notifications/instrumenter.rb:21:in `instrument'
    /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/notifications.rb:52:in `instrument'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/instrumentation.rb:29:in `process_action'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/base.rb:119:in `process'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/abstract_controller/rendering.rb:41:in `process'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal.rb:138:in `dispatch'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_controller/metal.rb:178:in `action'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/routing/route_set.rb:62:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/routing/route_set.rb:62:in `dispatch'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/routing/route_set.rb:27:in `call'
    /usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/route_set.rb:150:in `call'
    /usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/code_generation.rb:93:in `recognize'
    /usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/code_generation.rb:75:in `optimized_each'
    /usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/code_generation.rb:92:in `recognize'
    /usr/lib/ruby/gems/1.8/gems/rack-mount-0.7.1/lib/rack/mount/route_set.rb:141:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/routing/route_set.rb:493:in `call'
    /usr/lib/ruby/gems/1.8/gems/warden-1.0.3/lib/warden/manager.rb:35:in `call'
    /usr/lib/ruby/gems/1.8/gems/warden-1.0.3/lib/warden/manager.rb:34:in `catch'
    /usr/lib/ruby/gems/1.8/gems/warden-1.0.3/lib/warden/manager.rb:34:in `call'
    /usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/methodoverride.rb:24:in `call'
    /usr/lib/ruby/gems/1.8/gems/rack-restful_submit-1.2.1/lib/rack/rack-restful_submit.rb:25:in `call'
    /usr/lib/ruby/gems/1.8/gems/sass-3.1.4/lib/sass/../sass/plugin/rack.rb:54:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/head.rb:14:in `call'
    /usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/methodoverride.rb:24:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/params_parser.rb:21:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/flash.rb:182:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/session/abstract_store.rb:149:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/cookies.rb:302:in `call'
    /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/query_cache.rb:32:in `call'
    /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/connection_adapters/abstract/query_cache.rb:28:in `cache'
    /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/query_cache.rb:12:in `cache'
    /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/query_cache.rb:31:in `call'
    /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.10/lib/active_record/connection_adapters/abstract/connection_pool.rb:354:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/callbacks.rb:46:in `call'
    /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.10/lib/active_support/callbacks.rb:416:in `_run_call_callbacks'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/callbacks.rb:44:in `call'
    /usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/sendfile.rb:102:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/remote_ip.rb:48:in `call'
    /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.10/lib/action_dispatch/middleware/show_exceptions.rb:47:in `call'
    /usr/lib/ruby/gems/1.8/gems/railties-3.0.10/lib/rails/rack/logger.rb:13:in `call'
    /usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/runtime.rb:17:in `call'
    /usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/lock.rb:34:in `call'
    /usr/lib/ruby/gems/1.8/gems/railties-3.0.10/lib/rails/application.rb:168:in `call'
    /usr/lib/ruby/gems/1.8/gems/railties-3.0.10/lib/rails/application.rb:77:in `send'
    /usr/lib/ruby/gems/1.8/gems/railties-3.0.10/lib/rails/application.rb:77:in `method_missing'
    /usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/urlmap.rb:52:in `call'
    /usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/urlmap.rb:46:in `each'
    /usr/lib/ruby/gems/1.8/gems/rack-1.3.0/lib/rack/urlmap.rb:46:in `call'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:84:in `pre_process'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:82:in `catch'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:82:in `pre_process'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:57:in `process'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:42:in `receive_data'
    /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:256:in `run_machine'
    /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:256:in `run'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/backends/base.rb:61:in `start'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/server.rb:159:in `start'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/controllers/controller.rb:86:in `start'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/runner.rb:185:in `send'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/runner.rb:185:in `run_command'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/runner.rb:151:in `run!'
    /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/bin/thin:6
    /usr/bin/thin:19:in `load'
    /usr/bin/thin:19
Redirected to https://hp-bl480c-01.rhts.eng.bos.redhat.com/conductor/deployments/4
Completed 302 Found in 5487ms


Started GET "/conductor/deployments/4" for 10.11.9.88 at Tue Oct 18 12:37:37 -0400 2011
  Processing by DeploymentsController#show as HTML
  Parameters: {"id"=>"4"}
  User Load (0.6ms)  SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1
  Deployment Load (0.5ms)  SELECT "d



[root@hp-bl480c-01 aeolus-conductor]# rpm -qa | grep aeolus
aeolus-conductor-daemons-0.5.0-0.20111018162243gitf5c4fc6.fc15.noarch
rubygem-aeolus-cli-0.1.0-3.20111003133323git9451323.fc15.noarch
aeolus-all-0.5.0-0.20111018162243gitf5c4fc6.fc15.noarch
aeolus-configure-2.2.0-1.20111007151942git26136f2.fc15.noarch
aeolus-conductor-0.5.0-0.20111018162243gitf5c4fc6.fc15.noarch
aeolus-conductor-devel-0.5.0-0.20111018162243gitf5c4fc6.fc15.noarch
aeolus-conductor-doc-0.5.0-0.20111018162243gitf5c4fc6.fc15.noarch
rubygem-aeolus-image-0.1.0-3.20111003170706git8f23238.fc15.noarch
[root@hp-bl480c-01 aeolus-conductor]#

Comment 1 Aziza Karol 2011-10-19 12:21:57 UTC

*** Bug 747254 has been marked as a duplicate of this bug. ***

Comment 2 wes hayutin 2012-01-12 16:52:34 UTC

adding to sprint tracker

Comment 3 Petr Blaho 2012-01-16 15:27:36 UTC

Should be fixed by https://bugzilla.redhat.com/show_bug.cgi?id=743676

Still not in available RPM package.

Comment 4 Petr Blaho 2012-01-19 16:27:57 UTC

Created attachment 556322 [details]
Error message after deltacloud patch

Comment 5 Petr Blaho 2012-01-19 16:29:00 UTC

This error "malformed format string - %A" as seen in original attachment was resolved by https://bugzilla.redhat.com/show_bug.cgi?id=743676

Still not available as RPM package for F16.

But with that code applied me and fvollero have discovered that deltacloud-client is simply forwarding error messages to conductor. Forwarded error message is not looking good:

"InvalidParameterValue: The requested instance type's architecture (i386) does not match the architecture in the manifest for ami-7f2fe116 (x86_64)
REQUEST=ec2.us-east-1.amazonaws.com:443/?AWSAccessKeyId=AKIAJRXASLSZABFCZ24A&Action=RunInstances&AddressingType=public&ImageId=ami-7f2fe116&InstanceType=m1.small&KeyName=deploy_test_386_2_imported-ami-for-bug-test_1326987086_key_70080372
626040&MaxCount=1&MinCount=1&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2012-01-19T15%3A31%3A28.000Z&Version=2010-08-31&Signature=SYId63GhQ6qrsjaQaPxLhukqD%2BZbzCBbjiGjZo13MJs%3D 
REQUEST ID=0d060341-4aea-4413-900e-e4dd23006f86"

Comment 6 Francesco Vollero 2012-01-20 12:23:12 UTC

Here, https://bugzilla.redhat.com/show_bug.cgi?id=743676#c8 is evident that the problem on deltacloud side is solved and this patch will be included in the new release of deltacloud.

About the error message, this come from AWS gem, so i am not sure on how the conductor team should manage this.

Comment 7 Michal Fojtik 2012-01-20 12:28:26 UTC

The bug is indeed fixed in Deltacloud master. However I can't push it to F16 now because that will require additional 'patching' for the gem we already have there. You should wait for the official 0.5.0 release which should happen shortly. Then I'll bump the deltacloud-core release in F16.
Meanwhile there is a 0.5.0-rc1 package in rawhide you can try to use.

Comment 8 Michal Fojtik 2012-01-20 12:31:12 UTC

(In reply to comment #6)
> Here, https://bugzilla.redhat.com/show_bug.cgi?id=743676#c8 is evident that the
> problem on deltacloud side is solved and this patch will be included in the new
> release of deltacloud.
> 
> About the error message, this come from AWS gem, so i am not sure on how the
> conductor team should manage this.

It's easy. In Deltacloud drivers we use:

safely do
  #do_something
end

If this 'do_something' raise an exception, this is being caught by this safely...end block and then transformed to nice looking XML/HTML/JSON through 'views/errors/500.xml.haml'.
Then our ruby client, in case when it receive an 50x error, should instead of throwing '500 - Internal Server Error' throw an decent exception forwarded from Deltacloud 50x error XML page.

Comment 10 Shveta 2012-02-16 09:20:54 UTC

=============== UI Error ========================================

500 : Unhandled exception or status code (InvalidParameterValue: The requested instance type's architecture (x86_64) does not match the architecture in the manifest for ami-205fba49 (i386) REQUEST=ec2.us-east-1.amazonaws.com:443/?AWSAccessKeyId=AKIAI2KPFDYVZKSRTJMQ&Action=RunInstances&AddressingType=public&ImageId=ami-205fba49&InstanceType=c1.xlarge&KeyName=fedora_image_4_fedora-image-4_1329383822_key_70159176630200&MaxCount=1&MinCount=1&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2012-02-16T09%3A17%3A03.000Z&Version=2010-08-31&Signature=AbC96qH%2BV52%2BfdRltqc%2BVV9zMLYSF64edJqM4bclKE0%3D REQUEST ID=fc89b5b6-56ae-466e-8fec-806cae17804a )

=======================Rails.log===================================

500 : Unhandled exception or status code (InvalidParameterValue: The requested instance type's architecture (x86_64) does not match the architecture in the manifest for ami-205fba49 (i386)
  REQUEST=ec2.us-east-1.amazonaws.com:443/?AWSAccessKeyId=AKIAI2KPFDYVZKSRTJMQ&Action=RunInstances&AddressingType=public&ImageId=ami-205fba49&InstanceType=c1.xlarge&KeyName=fedora_image_4_fedora-image-4_1329383822_key_70159176630200&MaxCount=1&MinCount=1&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2012-02-16T09%3A17%3A03.000Z&Version=2010-08-31&Signature=AbC96qH%2BV52%2BfdRltqc%2BVV9zMLYSF64edJqM4bclKE0%3D 
  REQUEST ID=fc89b5b6-56ae-466e-8fec-806cae17804a )

    /usr/lib/ruby/gems/1.8/gems/aws-2.5.5/lib/ses/../awsbase/awsbase.rb:572:in `request_info_impl'
    /usr/lib/ruby/gems/1.8/gems/aws-2.5.5/lib/ec2/ec2.rb:177:in `request_info'
    /usr/lib/ruby/gems/1.8/gems/aws-2.5.5/lib/ec2/ec2.rb:577:in `launch_instances'
    /usr/share/deltacloud-core/lib/deltacloud/drivers/ec2/ec2_driver.rb:234:in `create_instance'
    /usr/share/deltacloud-core/lib/deltacloud/base_driver/exceptions.rb:151:in `call'
    /usr/share/deltacloud-core/lib/deltacloud/base_driver/exceptions.rb:151:in `safely'
    /usr/share/deltacloud-core/lib/deltacloud/drivers/ec2/ec2_driver.rb:233:in `create_instance'
    /usr/share/deltacloud-core/lib/deltacloud/server.rb:480
    /usr/share/deltacloud-core/lib/sinatra/rabbit.rb:125:in `instance_eval'
    /usr/share/deltacloud-core/lib/sinatra/rabbit.rb:125:in `POST /api/instances'

Comment 11 Shveta 2012-02-16 09:30:48 UTC

Created attachment 562445 [details]
import

Error can be seen while importing any image fedora , ubuntu , windows

Comment 12 Jan Provaznik 2012-02-16 10:01:44 UTC

This architecture mismatch error can occur for any type of provider, right?
Shouldn't then dc-core handle this error and raise some more specific exception type, e.g. InstanceArchitectureMismatch? 

From 50x errors, I see only 500 and 502 error pages on dc-core side now, none of them is specific enough for this type of exception.

Comment 13 Michal Fojtik 2012-02-16 12:08:59 UTC

The latest version of DC introduced 'hardware_profiles' attribute for all images. This attribute should contain all compatible hardware_profiles that could be used for launching an image.

As addition I'll add appropriate exception to exception list in DC. At least this error should be 502 (backend error) not 500 (DC error).

Comment 14 Hugh Brock 2012-02-20 21:19:19 UTC

reassigning to mfojtik and setting an appropriate severity.

Comment 15 Michal Fojtik 2012-02-21 10:06:30 UTC

Jan it's possible to implement arch specific checking in before image is launched?

Comment 16 Michal Fojtik 2012-02-21 11:38:08 UTC

Also my suggestion is to create a new bug, because this one is not really a case we're trying to solve here :-)

Comment 17 Jan Provaznik 2012-02-21 12:03:03 UTC

We do architecture checking for for our own image builds, but we can't do this for imported images because architecture is not provided to conductor from providers.

If new DC API returns hw profiles valid for an image, it would help: according to API doc, hw profile contains architecture info so we could save it when importing an image. Nit: for our builds, arch info is saved in template, for imported images we don't create template at all, but we could save architecture as image's attribute in warehouse.

Changing error from 500 to 502 (backend error) won't help much - it's too general error, an architecture mismatch specific error would be needed (my comment https://bugzilla.redhat.com/show_bug.cgi?id=747048#c12), but if we will be able to get architecture for imported images, we probably don't need it.

Comment 18 Jan Provaznik 2012-02-21 12:49:21 UTC

Agree with Michal - origin problem reported in this bug was already solved. New bug related to error message on architecture mismatch is here: https://bugzilla.redhat.com/show_bug.cgi?id=795743

I would suggest to close this bug.

Comment 19 Ronelle Landy 2012-02-27 21:15:17 UTC

Verified that Deltacloud now  returns the hardware profiles for any image queried:

 curl -X GET --user "uname:password" "http://qe-blade-09.idm.lab.bos.redhat.com:3007/api/images/8b2bbc41-1ab4-49b4-bd40-8df203e542e0?format=xml"

<?xml version='1.0' encoding='utf-8' ?>
<image href='http://qe-blade-09.idm.lab.bos.redhat.com:3007/api/images/8b2bbc41-1ab4-49b4-bd40-8df203e542e0' id='8b2bbc41-1ab4-49b4-bd40-8df203e542e0'>
  <name>f105db41-a7c6-4538-8b69-3bf7b9697e7e</name>
  <owner_id>admin@internal</owner_id>
  <description>Template by iwhd</description>
  <architecture>x86_64</architecture>
  <state>ok</state>
  <hardware_profiles>
    <hardware_profile href='http://qe-blade-09.idm.lab.bos.redhat.com:3007/api/hardware_profiles/SERVER' id='SERVER' rel='hardware_profile'></hardware_profile>
    <hardware_profile href='http://qe-blade-09.idm.lab.bos.redhat.com:3007/api/hardware_profiles/DESKTOP' id='DESKTOP' rel='hardware_profile'></hardware_profile>
  </hardware_profiles>
  <actions>
    <link href='http://qe-blade-09.idm.lab.bos.redhat.com:3007/api/instances;image_id=8b2bbc41-1ab4-49b4-bd40-8df203e542e0' method='post' rel='create_instance' />
  </actions>
</image>


**************

Hardware profiles check with Deltacloud git commit:

>> cat master
f5983903db4b7e99a9a5b7f53791863f9f585940


*************

Also verified the change to the 502 error:

 curl -X  POST  -F "image_id=ami-da2bf9b3" -F "hwp_id=m1.micro" --user "uname:password" 'http://qe-blade-09.idm.lab.bos.redhat.com:3008/api/instances?format=xml'

<error status='502' url='http://qe-blade-09.idm.lab.bos.redhat.com:3008/api/instances?format=xml'>
  <kind>backend_error</kind>
  <backend driver='ec2'>
    <code>502</code>
  </backend>
  <message><![CDATA[InvalidParameterValue: Invalid value 'm1.micro' for InstanceType.
  REQUEST=ec2.us-east-1.amazonaws.com:443/?AWSAccessKeyId=AKIAJCBB265A57CGKR2Q&Action=RunInstances&AddressingType=public&ImageId=ami-da2bf9b3&InstanceType=m1.micro&MaxCount=1&MinCount=1&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2012-02-27T21%3A13%3A30.000Z&Version=2010-08-31&Signature=TGDbaBMXIor1f9lvqVL1TofShYbcIAshdzeQONcYvEY%3D 
  REQUEST ID=47ac3531-4773-4a33-9e74-f344ee71e3a4]]></message>
</error>

****************************

Work needed to be done for Conductor to use this info is tracked here:

https://bugzilla.redhat.com/show_bug.cgi?id=795743

Taking the above verified changes into account and comment 18 above - closing this BZ as Verified.

Comment 20 errata-xmlrpc 2012-05-15 21:11:54 UTC

Since the problem described in this bug report should be
resolved in a recent advisory, it has been closed with a
resolution of ERRATA.

For information on the advisory, and where to find the updated
files, follow the link below.

If the solution does not work for you, open a new bug report.

http://rhn.redhat.com/errata/RHEA-2012-0583.html

Note You need to log in before you can comment on or make changes to this bug.