| Summary: | Deployables, unable to launch a deployable. | ||||||||
|---|---|---|---|---|---|---|---|---|---|
| Product: | [Retired] CloudForms Cloud Engine | Reporter: | wes hayutin <whayutin> | ||||||
| Component: | aeolus-conductor | Assignee: | Angus Thomas <athomas> | ||||||
| Status: | CLOSED ERRATA | QA Contact: | wes hayutin <whayutin> | ||||||
| Severity: | unspecified | Docs Contact: | |||||||
| Priority: | unspecified | ||||||||
| Version: | 1.0.0 | CC: | akarol, dajohnso, deltacloud-maint, mfojtik, ssachdev | ||||||
| Target Milestone: | rc | ||||||||
| Target Release: | --- | ||||||||
| Hardware: | Unspecified | ||||||||
| OS: | Unspecified | ||||||||
| Whiteboard: | |||||||||
| Fixed In Version: | Doc Type: | Bug Fix | |||||||
| Doc Text: | Story Points: | --- | |||||||
| Clone Of: | Environment: | ||||||||
| Last Closed: | 2012-05-15 22:03:41 UTC | Type: | --- | ||||||
| Regression: | --- | Mount Type: | --- | ||||||
| Documentation: | --- | CRM: | |||||||
| Verified Versions: | Category: | --- | |||||||
| oVirt Team: | --- | RHEL 7.3 requirements from Atomic Host: | |||||||
| Cloudforms Team: | --- | Target Upstream Version: | |||||||
| Attachments: |
|
||||||||
Created attachment 525126 [details]
ss
Seems like Deltacloud is not reloading features/supported operations when switching provider. Richard send us patch for this few days ago and it should be fixed in upcoming 0.4.1. Meanwhile you can check this using latest nightly build. Correction: s/Deltacloud/Deltacloud Ruby client/ making sure all the bugs are at the right version for future queries Deployment is getting launched successfully. The above error "Method not allowed for this resource" is not observed now.
See attached screenshot.
Started POST "/conductor/deployments" for 10.65.193.181 at Tue Oct 04 06:21:26 -0400 2011
Processing by DeploymentsController#create as HTML
Parameters: {"commit"=>"Launch this deployment", "authenticity_token"=>"aVi/iD0+Ui99C10Gevfku2XuXbGa2cM5ZE7n4bfgTyQ=", "utf8"=>"✓", "deployment"=>{"name"=>"rhev6_dep", "frontend_realm_id"=>"1", "deployable_xml"=>"<deployable name=\"aziza\">\r\n<description>This is an example deployment</description>\r\n<assemblies>\r\n<assembly name=\"frontend\" hwp=\"hwp1\">\r\n<image id=\"7c80deb7-5df4-4f11-b994-628560e2c82b\" build=\"11e00cab-5dac-4cff-ad37-0f499dea06be\">\r\n</image>\r\n</assembly>\r\n</assemblies>\r\n</deployable>\r\n", "pool_id"=>"1"}}
User Load (2.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1
Pool Load (0.5ms) SELECT "pools".* FROM "pools" WHERE "pools"."id" = 1 LIMIT 1
BasePermissionObject Load (0.4ms) SELECT "base_permission_objects".* FROM "base_permission_objects" WHERE "base_permission_objects"."name" = 'general_permission_scope' LIMIT 1
Permission Load (1.7ms) SELECT * FROM (SELECT DISTINCT ON ("permissions".id) "permissions".id, permissions.id AS alias_0 FROM "permissions" LEFT OUTER JOIN "roles" ON "roles"."id" = "permissions"."role_id" LEFT OUTER JOIN "privileges" ON "privileges"."role_id" = "roles"."id" WHERE ("permissions".permission_object_id = 1 AND "permissions".permission_object_type = 'Pool') AND (permissions.user_id=1 and
privileges.target_type='Deployment' and
privileges.action='create')) AS id_list ORDER BY id_list.alias_0 LIMIT 1
Permission Load (1.8ms) SELECT "permissions"."id" AS t0_r0, "permissions"."role_id" AS t0_r1, "permissions"."user_id" AS t0_r2, "permissions"."permission_object_id" AS t0_r3, "permissions"."permission_object_type" AS t0_r4, "permissions"."lock_version" AS t0_r5, "permissions"."created_at" AS t0_r6, "permissions"."updated_at" AS t0_r7, "roles"."id" AS t1_r0, "roles"."name" AS t1_r1, "roles"."scope" AS t1_r2, "roles"."lock_version" AS t1_r3, "roles"."created_at" AS t1_r4, "roles"."updated_at" AS t1_r5, "roles"."assign_to_owner" AS t1_r6, "privileges"."id" AS t2_r0, "privileges"."role_id" AS t2_r1, "privileges"."target_type" AS t2_r2, "privileges"."action" AS t2_r3, "privileges"."lock_version" AS t2_r4, "privileges"."created_at" AS t2_r5, "privileges"."updated_at" AS t2_r6 FROM "permissions" LEFT OUTER JOIN "roles" ON "roles"."id" = "permissions"."role_id" LEFT OUTER JOIN "privileges" ON "privileges"."role_id" = "roles"."id" WHERE "permissions"."id" IN (1) AND ("permissions".permission_object_id = 1 AND "permissions".permission_object_type = 'Pool') AND (permissions.user_id=1 and
privileges.target_type='Deployment' and
privileges.action='create') ORDER BY permissions.id ASC
SQL (0.2ms) BEGIN
SQL (0.5ms) SELECT 1 FROM "deployments" WHERE "deployments"."pool_id" = 1 AND ("deployments"."name" = 'rhev6_dep') LIMIT 1
PoolFamily Load (0.4ms) SELECT "pool_families".* FROM "pool_families" WHERE "pool_families"."id" = 1 LIMIT 1
ProviderAccount Load (0.6ms) SELECT * FROM "provider_accounts" INNER JOIN "pool_families_provider_accounts" ON "provider_accounts".id = "pool_families_provider_accounts".provider_account_id WHERE ("pool_families_provider_accounts".pool_family_id = 1 )
Provider Load (0.4ms) SELECT "providers".* FROM "providers" WHERE "providers"."id" = 1 LIMIT 1
SQL (0.9ms) INSERT INTO "deployments" ("owner_id", "frontend_realm_id", "realm_id", "deployable_xml", "scheduled_for_deletion", "name", "updated_at", "lock_version", "created_at", "pool_id") VALUES (1, 1, NULL, '<deployable name="aziza">
<description>This is an example deployment</description>
<assemblies>
<assembly name="frontend" hwp="hwp1">
<image id="7c80deb7-5df4-4f11-b994-628560e2c82b" build="11e00cab-5dac-4cff-ad37-0f499dea06be">
</image>
</assembly>
</assemblies>
</deployable>
', 'f', 'rhev6_dep', '2011-10-04 10:21:26.381055', 0, '2011-10-04 10:21:26.381055', 1) RETURNING "id"
Role Load (0.5ms) SELECT "roles".* FROM "roles" WHERE (assign_to_owner ='t' and scope='Deployment')
SQL (0.4ms) SELECT 1 FROM "permissions" WHERE "permissions"."permission_object_id" = 6 AND "permissions"."permission_object_type" = 'Deployment' AND "permissions"."role_id" = 15 AND ("permissions"."user_id" = 1) LIMIT 1
SQL (0.4ms) INSERT INTO "permissions" ("permission_object_type", "lock_version", "created_at", "user_id", "role_id", "permission_object_id", "updated_at") VALUES ('Deployment', 0, '2011-10-04 10:21:26.391060', 1, 15, 6, '2011-10-04 10:21:26.391060') RETURNING "id"
SQL (0.7ms) COMMIT
SQL (0.1ms) BEGIN
HardwareProfile Load (0.4ms) SELECT "hardware_profiles".* FROM "hardware_profiles" WHERE "hardware_profiles"."provider_id" IS NULL AND "hardware_profiles"."name" = 'hwp1' LIMIT 1
FrontendRealm Load (0.3ms) SELECT "frontend_realms".* FROM "frontend_realms" WHERE "frontend_realms"."id" = 1 LIMIT 1
SQL (0.3ms) SELECT 1 FROM "instances" WHERE "instances"."pool_id" = 1 AND ("instances"."name" = 'rhev6_dep/frontend') LIMIT 1
Quota Load (0.3ms) SELECT "quotas".* FROM "quotas" WHERE "quotas"."id" = 1 LIMIT 1
Pool Load (0.2ms) SELECT "pools".* FROM "pools" WHERE "pools"."id" = 1 LIMIT 1
Quota Load (0.2ms) SELECT "quotas".* FROM "quotas" WHERE "quotas"."id" = 2 LIMIT 1
Quota Load (0.2ms) SELECT "quotas".* FROM "quotas" WHERE "quotas"."id" = 4 LIMIT 1
SQL (0.6ms) INSERT INTO "instances" ("acc_running_time", "instance_hwp_id", "lock_version", "state", "provider_account_id", "provider_image_uuid", "updated_at", "deployment_id", "private_addresses", "owner_id", "last_error", "acc_shutting_down_time", "created_at", "name", "pool_id", "assembly_xml", "image_uuid", "time_last_pending", "provider_instance_id", "frontend_realm_id", "time_last_stopped", "public_addresses", "acc_pending_time", "time_last_shutting_down", "external_key", "time_last_running", "acc_stopped_time", "image_build_uuid", "hardware_profile_id") VALUES (0, NULL, 0, 'new', NULL, NULL, '2011-10-04 10:21:26.435758', 6, NULL, 1, NULL, 0, '2011-10-04 10:21:26.435758', 'rhev6_dep/frontend', 1, '<assembly name="frontend" hwp="hwp1">
<image id="7c80deb7-5df4-4f11-b994-628560e2c82b" build="11e00cab-5dac-4cff-ad37-0f499dea06be">
</image>
</assembly>', '7c80deb7-5df4-4f11-b994-628560e2c82b', NULL, NULL, 1, NULL, NULL, 0, NULL, NULL, NULL, 0, '11e00cab-5dac-4cff-ad37-0f499dea06be', 1) RETURNING "id"
Role Load (0.4ms) SELECT "roles".* FROM "roles" WHERE (assign_to_owner ='t' and scope='Instance')
SQL (0.4ms) SELECT 1 FROM "permissions" WHERE "permissions"."permission_object_id" = 6 AND "permissions"."permission_object_type" = 'Instance' AND "permissions"."role_id" = 24 AND ("permissions"."user_id" = 1) LIMIT 1
SQL (0.4ms) INSERT INTO "permissions" ("permission_object_type", "lock_version", "created_at", "user_id", "role_id", "permission_object_id", "updated_at") VALUES ('Instance', 0, '2011-10-04 10:21:26.454002', 1, 24, 6, '2011-10-04 10:21:26.454002') RETURNING "id"
SQL (0.8ms) INSERT INTO "events" ("status_code", "created_at", "summary", "source_id", "source_type", "event_time", "updated_at", "description") VALUES (NULL, '2011-10-04 10:21:26.459956', 'created', 6, 'Instance', '2011-10-04 10:21:26.435758', '2011-10-04 10:21:26.459956', NULL) RETURNING "id"
SQL (0.8ms) INSERT INTO "tasks" ("task_target_type", "time_ended", "time_started", "state", "args", "user", "failure_code", "task_target_id", "time_submitted", "message", "lock_version", "type", "action", "created_at") VALUES ('Instance', NULL, NULL, 'queued', NULL, 1, NULL, 6, NULL, NULL, 0, 'InstanceTask', 'create', '2011-10-04 10:21:26.468136') RETURNING "id"
SQL (0.6ms) COMMIT
Instance Load (0.7ms) SELECT "instances".* FROM "instances" WHERE "instances"."id" = 6 LIMIT 1
Pool Load (0.4ms) SELECT "pools".* FROM "pools" WHERE "pools"."id" = 1 LIMIT 1
PoolFamily Load (0.4ms) SELECT "pool_families".* FROM "pool_families" WHERE "pool_families"."id" = 1 LIMIT 1
ProviderAccount Load (0.7ms) SELECT * FROM "provider_accounts" INNER JOIN "pool_families_provider_accounts" ON "provider_accounts".id = "pool_families_provider_accounts".provider_account_id WHERE ("pool_families_provider_accounts".pool_family_id = 1 )
Quota Load (0.4ms) SELECT "quotas".* FROM "quotas" WHERE "quotas"."id" = 2 LIMIT 1
Quota Load (0.4ms) SELECT "quotas".* FROM "quotas" WHERE "quotas"."id" = 1 LIMIT 1
User Load (0.5ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1
Quota Load (0.4ms) SELECT "quotas".* FROM "quotas" WHERE "quotas"."id" = 4 LIMIT 1
Provider Load (1.1ms) SELECT "providers".* FROM "providers" WHERE "providers"."id" = 1 LIMIT 1
HardwareProfile Load (0.9ms) SELECT "hardware_profiles".* FROM "hardware_profiles" WHERE "hardware_profiles"."id" = 1 LIMIT 1
HardwareProfile Load (0.5ms) SELECT "hardware_profiles".* FROM "hardware_profiles" WHERE ("hardware_profiles".provider_id = 1)
HardwareProfileProperty Load (0.4ms) SELECT "hardware_profile_properties".* FROM "hardware_profile_properties" WHERE "hardware_profile_properties"."id" = 1 LIMIT 1
......
[root@dell-per905-01 templates]# rpm -qa | egrep 'aeolus|imagefactory'
aeolus-all-0.4.0-0.20111003184622git65a7d19.fc15.noarch
aeolus-conductor-doc-0.4.0-0.20111003184622git65a7d19.fc15.noarch
rubygem-imagefactory-console-0.5.0-4.20110824113238gitd9debef.fc15.noarch
rubygem-aeolus-image-0.1.0-3.20111003170706git8f23238.fc15.noarch
rubygem-aeolus-cli-0.1.0-3.20111003133323git9451323.fc15.noarch
aeolus-configure-2.0.2-4.20110930103205gitaf78594.fc15.noarch
aeolus-conductor-daemons-0.4.0-0.20111003184622git65a7d19.fc15.noarch
imagefactory-0.6.2_11_g7b94a4a-1.fc15.noarch
aeolus-conductor-0.4.0-0.20111003184622git65a7d19.fc15.noarch
Created attachment 526218 [details]
launch deployment
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 |
recreate: 0. setup conductor admin appropriately 1. create a deployable 2. launch L (0.1ms) BEGIN AREL (0.4ms) UPDATE "tasks" SET "time_submitted" = '2011-09-27 13:01:36.047224', "lock_version" = 1, "state" = 'pending' WHERE "tasks"."type" = 'InstanceTask' AND ("tasks"."id" = 2 AND "tasks"."lock_version" = 0) SQL (8.4ms) COMMIT InstanceKey Load (0.4ms) SELECT "instance_keys".* FROM "instance_keys" WHERE ("instance_keys".instance_id = 2) LIMIT 1 Credential Load (0.3ms) SELECT "credentials".* FROM "credentials" WHERE ("credentials".provider_account_id = 1) CredentialDefinition Load (0.3ms) SELECT "credential_definitions".* FROM "credential_definitions" WHERE "credential_definitions"."id" = 13 LIMIT 1 CredentialDefinition Load (0.2ms) SELECT "credential_definitions".* FROM "credential_definitions" WHERE "credential_definitions"."id" = 14 LIMIT 1 ProviderType Load (0.2ms) SELECT "provider_types".* FROM "provider_types" WHERE "provider_types"."id" = 8 LIMIT 1 Method not allowed for this resource /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:402:in `handle_backend_error' /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:310:in `method_missing' /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:362: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:359:in `send' /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:359: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/models/instance.rb:249:in `create_auth_key' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/associations/association_proxy.rb:222:in `send' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/associations/association_proxy.rb:222:in `method_missing' /usr/share/aeolus-conductor/app/util/taskomatic.rb:30:in `create_instance' /usr/share/aeolus-conductor/app/models/deployment.rb:174:in `launch' /usr/share/aeolus-conductor/app/models/deployment.rb:151:in `each' /usr/share/aeolus-conductor/app/models/deployment.rb:151:in `launch' /usr/share/aeolus-conductor/app/controllers/deployments_controller.rb:94:in `create' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/mime_responds.rb:264:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/mime_responds.rb:264:in `retrieve_response_from_mimes' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/mime_responds.rb:191:in `respond_to' /usr/share/aeolus-conductor/app/controllers/deployments_controller.rb:92:in `create' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/implicit_render.rb:4:in `send_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/implicit_render.rb:4:in `send_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/base.rb:150:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/rendering.rb:11:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/callbacks.rb:18:in `process_action' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:441:in `_run__1359547276__process_action__1623385099__callbacks' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:410:in `send' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:410:in `_run_process_action_callbacks' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:94:in `send' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:94:in `run_callbacks' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/callbacks.rb:17:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/instrumentation.rb:30:in `process_action' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/notifications.rb:52:in `instrument' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/notifications/instrumenter.rb:21:in `instrument' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/notifications.rb:52:in `instrument' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/instrumentation.rb:29:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/rescue.rb:17:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/base.rb:119:in `process' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/rendering.rb:41:in `process' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal.rb:138:in `dispatch' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal.rb:178:in `action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/routing/route_set.rb:62:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/routing/route_set.rb:62:in `dispatch' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/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.9/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.9/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/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.9/lib/action_dispatch/middleware/params_parser.rb:21:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/flash.rb:182:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/session/abstract_store.rb:149:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/cookies.rb:302:in `call' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/query_cache.rb:32:in `call' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/connection_adapters/abstract/query_cache.rb:28:in `cache' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/query_cache.rb:12:in `cache' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/query_cache.rb:31:in `call' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/connection_adapters/abstract/connection_pool.rb:354:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/callbacks.rb:46:in `call' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:416:in `_run_call_callbacks' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/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.9/lib/action_dispatch/middleware/remote_ip.rb:48:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/show_exceptions.rb:47:in `call' /usr/lib/ruby/gems/1.8/gems/railties-3.0.9/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.9/lib/rails/application.rb:168:in `call' /usr/lib/ruby/gems/1.8/gems/railties-3.0.9/lib/rails/application.rb:77:in `send' /usr/lib/ruby/gems/1.8/gems/railties-3.0.9/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.4ms) SELECT 1 FROM "instances" WHERE "instances"."pool_id" = 1 AND ("instances"."name" = 'dfgdfgsdg/frontend') AND ("instances".id <> 2) LIMIT 1 Pool Load (0.3ms) SELECT "pools".* FROM "pools" WHERE "pools"."id" = 1 LIMIT 1 Quota Load (0.2ms) SELECT "quotas".* FROM "quotas" WHERE "quotas"."id" = 2 LIMIT 1 AREL (0.4ms) UPDATE "instances" SET "provider_account_id" = 1, "lock_version" = 1, "state" = 'create_failed', "updated_at" = '2011-09-27 13:01:36.111558' WHERE ("instances"."id" = 2 AND "instances"."lock_version" = 0) SQL (0.3ms) INSERT INTO "events" ("created_at", "updated_at", "source_id", "source_type", "summary", "status_code", "description", "event_time") VALUES ('2011-09-27 13:01:36.115784', '2011-09-27 13:01:36.115784', 2, 'Instance', 'state changed to create_failed', NULL, NULL, '2011-09-27 13:01:36.000000') RETURNING "id" SQL (5.5ms) COMMIT SQL (0.1ms) BEGIN AREL (0.4ms) UPDATE "tasks" SET "lock_version" = 2, "state" = 'failed', "time_ended" = '2011-09-27 13:01:36.126197' WHERE "tasks"."type" = 'InstanceTask' AND ("tasks"."id" = 2 AND "tasks"."lock_version" = 1) SQL (4.4ms) COMMIT Method not allowed for this resource /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:402:in `handle_backend_error' /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:310:in `method_missing' /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:362: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:359:in `send' /usr/lib/ruby/gems/1.8/gems/deltacloud-client-0.4.0/lib/deltacloud.rb:359: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/models/instance.rb:249:in `create_auth_key' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/associations/association_proxy.rb:222:in `send' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/associations/association_proxy.rb:222:in `method_missing' /usr/share/aeolus-conductor/app/util/taskomatic.rb:30:in `create_instance' /usr/share/aeolus-conductor/app/models/deployment.rb:174:in `launch' /usr/share/aeolus-conductor/app/models/deployment.rb:151:in `each' /usr/share/aeolus-conductor/app/models/deployment.rb:151:in `launch' /usr/share/aeolus-conductor/app/controllers/deployments_controller.rb:94:in `create' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/mime_responds.rb:264:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/mime_responds.rb:264:in `retrieve_response_from_mimes' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/mime_responds.rb:191:in `respond_to' /usr/share/aeolus-conductor/app/controllers/deployments_controller.rb:92:in `create' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/implicit_render.rb:4:in `send_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/implicit_render.rb:4:in `send_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/base.rb:150:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/rendering.rb:11:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/callbacks.rb:18:in `process_action' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:441:in `_run__1359547276__process_action__1623385099__callbacks' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:410:in `send' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:410:in `_run_process_action_callbacks' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:94:in `send' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:94:in `run_callbacks' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/callbacks.rb:17:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/instrumentation.rb:30:in `process_action' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/notifications.rb:52:in `instrument' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/notifications/instrumenter.rb:21:in `instrument' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/notifications.rb:52:in `instrument' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/instrumentation.rb:29:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/rescue.rb:17:in `process_action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/base.rb:119:in `process' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/abstract_controller/rendering.rb:41:in `process' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal.rb:138:in `dispatch' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_controller/metal.rb:178:in `action' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/routing/route_set.rb:62:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/routing/route_set.rb:62:in `dispatch' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/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.9/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.9/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/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.9/lib/action_dispatch/middleware/params_parser.rb:21:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/flash.rb:182:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/session/abstract_store.rb:149:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/cookies.rb:302:in `call' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/query_cache.rb:32:in `call' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/connection_adapters/abstract/query_cache.rb:28:in `cache' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/query_cache.rb:12:in `cache' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/query_cache.rb:31:in `call' /usr/lib/ruby/gems/1.8/gems/activerecord-3.0.9/lib/active_record/connection_adapters/abstract/connection_pool.rb:354:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/callbacks.rb:46:in `call' /usr/lib/ruby/gems/1.8/gems/activesupport-3.0.9/lib/active_support/callbacks.rb:416:in `_run_call_callbacks' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/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.9/lib/action_dispatch/middleware/remote_ip.rb:48:in `call' /usr/lib/ruby/gems/1.8/gems/actionpack-3.0.9/lib/action_dispatch/middleware/show_exceptions.rb:47:in `call' /usr/lib/ruby/gems/1.8/gems/railties-3.0.9/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.9/lib/rails/application.rb:168:in `call' /usr/lib/ruby/gems/1.8/gems/railties-3.0.9/lib/rails/application.rb:77:in `send' /usr/lib/ruby/gems/1.8/gems/railties-3.0.9/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://10.11.230.102/conductor/deployments/3 Completed 302 Found in 1177ms Started GET "/conductor/deployments/3" for 10.11.8.118 at Tue Sep 27 09:01:36 -0400 2011 Processing by DeploymentsController#show as HTML Parameters: {"id"=>"3"} User Load (0.6ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Deployment Load (0.3ms) SELECT "deployments".* FROM "deployments" ORDER BY name asc LIMIT 30 OFFSET 0 BasePermissionObject Load (0.2ms) SELECT "base_permission_objects".* FROM "base_permission_objects" WHERE "base_permission_objects"."name" = 'general_permission_scope' LIM