Bug 743905
Summary: | RHEVM instances when launched, state goes to PENDING -> STOPPED | ||
---|---|---|---|
Product: | [Retired] CloudForms Cloud Engine | Reporter: | wes hayutin <whayutin> |
Component: | rubygem-deltacloud-client | Assignee: | Michal Fojtik <mfojtik> |
Status: | CLOSED DUPLICATE | QA Contact: | wes hayutin <whayutin> |
Severity: | unspecified | Docs Contact: | |
Priority: | unspecified | ||
Version: | 1.0.0 | CC: | akarol, cpelland, dajohnso, deltacloud-maint, dgao, imain, mfojtik, rananda, 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: | 2011-10-07 19:05:11 UTC | Type: | --- |
Regression: | --- | Mount Type: | --- |
Documentation: | --- | CRM: | |
Verified Versions: | Category: | --- | |
oVirt Team: | --- | RHEL 7.3 requirements from Atomic Host: | |
Cloudforms Team: | --- | Target Upstream Version: | |
Embargoed: |
Description
wes hayutin
2011-10-06 12:39:44 UTC
In RHEV-M when you create a new instance it goes from CREATE -> PENDING -> STOPPED, Conductor is trying to 'start' the new instance when it is in 'PENDING' state. I fixed DC state machine to disable 'start' operation when the instance is in PENDING state. However you still need to check your code. (patch sent to deltacloud-dev list) recreated... Starting Deltacloud API :: mock :: http://localhost:3002/api /usr/bin/deltacloudd[24564]: >> Thin web server (v1.2.11 codename Bat-Shit Crazy) /usr/bin/deltacloudd[24564]: >> Debugging ON /usr/bin/deltacloudd[24564]: >> Maximum connections set to 1024 /usr/bin/deltacloudd[24564]: >> Listening on localhost:3002, CTRL+C to stop /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:39:20 -0400 2011) [GET] [Mock] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:39:20 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:39:21 -0400 2011) [GET] [Mock] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:39:21 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api/instances (for 127.0.0.1 at Thu Oct 06 18:39:21 -0400 2011) [POST] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {"realm_id"=>"7c8a7614-b950-11e0-86c5-001a4a104801", "name"=>"asdfg2-frontend", "hwp_memory"=>"512", "image_id"=>"4de45618-73f0-4485-8a4f-1c8bbd0785a2", "keyname"=>"", "hwp_id"=>"SERVER", "hwp_cpu"=>"1", "hwp_storage"=>"1"} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 201 | application/xml | http://localhost:3002/api/instances /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:39:59 -0400 2011) [GET] [Mock] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:39:59 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api/instances/167b0675-869b-444c-b9b1-3c7696a3b2d4 (for 127.0.0.1 at Thu Oct 06 18:39:59 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.383139 | 0.000000 | 200 | application/xml | http://localhost:3002/api/instances/167b0675-869b-444c-b9b1-3c7696a3b2d4 /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:40:00 -0400 2011) [GET] [Mock] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:40:00 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api/instance_states (for 127.0.0.1 at Thu Oct 06 18:40:00 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api/instance_states /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:40:00 -0400 2011) [GET] [Mock] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:40:00 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api/instances/167b0675-869b-444c-b9b1-3c7696a3b2d4 (for 127.0.0.1 at Thu Oct 06 18:40:00 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.408241 | 0.000000 | 200 | application/xml | http://localhost:3002/api/instances/167b0675-869b-444c-b9b1-3c7696a3b2d4 /usr/bin/deltacloudd[24564]: Processing /api/instances/167b0675-869b-444c-b9b1-3c7696a3b2d4/start (for 127.0.0.1 at Thu Oct 06 18:40:01 -0400 2011) [POST] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: RestClient::BadRequest:400 Bad Request /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/abstract_response.rb:48:in `return!' /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:220: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/share/deltacloud-core/bin/../lib/deltacloud/drivers/rhevm/rhevm_client.rb:79:in `vm_action' /usr/share/deltacloud-core/bin/../lib/deltacloud/drivers/rhevm/rhevm_driver.rb:151:in `start_instance' /usr/share/deltacloud-core/bin/../lib/deltacloud/base_driver/exceptions.rb:151:in `call' /usr/share/deltacloud-core/bin/../lib/deltacloud/base_driver/exceptions.rb:151:in `safely' /usr/share/deltacloud-core/bin/../lib/deltacloud/drivers/rhevm/rhevm_driver.rb:150:in `start_instance' /usr/share/deltacloud-core/bin/../lib/deltacloud/helpers/application_helper.rb:128:in `send' /usr/share/deltacloud-core/bin/../lib/deltacloud/helpers/application_helper.rb:128:in `instance_action' /usr/share/deltacloud-core/bin/../server.rb:475 /usr/share/deltacloud-core/bin/../lib/sinatra/rabbit.rb:125:in `instance_eval' /usr/share/deltacloud-core/bin/../lib/sinatra/rabbit.rb:125:in `POST /api/instances/:id/start' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:1057:in `call' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:1057:in `compile!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:643:in `instance_eval' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:643:in `route_eval' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:627:in `route!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:675:in `process_route' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:672:in `catch' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:672:in `process_route' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:626:in `route!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:625:in `each' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:625:in `route!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:760:in `dispatch!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:553:in `call!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:725:in `instance_eval' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:725:in `invoke' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:725:in `catch' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:725:in `invoke' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:553:in `call!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:538:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_syslog.rb:48:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_date.rb:31:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_accept.rb:149:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_driver_select.rb:45:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_matrix_params.rb:102:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_runtime.rb:36:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_etag.rb:41:in `call' /usr/lib/ruby/gems/1.8/gems/rack-accept-0.4.3/lib/rack/accept/context.rb:22: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/sinatra-1.1.2/lib/sinatra/base.rb:1167:in `call' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:1193:in `synchronize' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:1167: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/eventmachine-0.12.10/lib/eventmachine.rb:1060:in `call' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1060:in `spawn_threadpool' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1057:in `initialize' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1057:in `new' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1057:in `spawn_threadpool' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1049:in `defer' /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:54: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/share/deltacloud-core/bin/deltacloudd:223 /usr/bin/deltacloudd:5:in `load' /usr/bin/deltacloudd:5 /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 400 | application/xml | http://localhost:3002/api/instances/167b0675-869b-444c-b9b1-3c7696a3b2d4/start /usr/bin/deltacloudd[24564]: 127.0.0.1 - - [06/Oct/2011 18:40:01] "POST /api/instances/167b0675-869b-444c-b9b1-3c7696a3b2d4/start HTTP/1.1" 400 191 0.8166 /usr/bin/deltacloudd[24564]: Processing /api/instances/167b0675-869b-444c-b9b1-3c7696a3b2d4 (for 127.0.0.1 at Thu Oct 06 18:40:01 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.341358 | 0.000000 | 200 | application/xml | http://localhost:3002/api/instances/167b0675-869b-444c-b9b1-3c7696a3b2d4 /usr/bin/deltacloudd[24564]: Processing /api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c (for 127.0.0.1 at Thu Oct 06 18:40:02 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.327879 | 0.000000 | 200 | application/xml | http://localhost:3002/api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c /usr/bin/deltacloudd[24564]: Processing /api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c (for 127.0.0.1 at Thu Oct 06 18:40:02 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.400129 | 0.000000 | 200 | application/xml | http://localhost:3002/api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:40:03 -0400 2011) [GET] [Mock] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:40:03 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api/instance_states (for 127.0.0.1 at Thu Oct 06 18:40:03 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api/instance_states /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:40:03 -0400 2011) [GET] [Mock] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api (for 127.0.0.1 at Thu Oct 06 18:40:03 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 200 | application/xml | http://localhost:3002/api /usr/bin/deltacloudd[24564]: Processing /api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c (for 127.0.0.1 at Thu Oct 06 18:40:03 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.361476 | 0.000000 | 200 | application/xml | http://localhost:3002/api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c /usr/bin/deltacloudd[24564]: Processing /api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c/start (for 127.0.0.1 at Thu Oct 06 18:40:03 -0400 2011) [POST] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: RestClient::BadRequest:400 Bad Request /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/abstract_response.rb:48:in `return!' /usr/lib/ruby/gems/1.8/gems/rest-client-1.6.1/lib/restclient/request.rb:220: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/share/deltacloud-core/bin/../lib/deltacloud/drivers/rhevm/rhevm_client.rb:79:in `vm_action' /usr/share/deltacloud-core/bin/../lib/deltacloud/drivers/rhevm/rhevm_driver.rb:151:in `start_instance' /usr/share/deltacloud-core/bin/../lib/deltacloud/base_driver/exceptions.rb:151:in `call' /usr/share/deltacloud-core/bin/../lib/deltacloud/base_driver/exceptions.rb:151:in `safely' /usr/share/deltacloud-core/bin/../lib/deltacloud/drivers/rhevm/rhevm_driver.rb:150:in `start_instance' /usr/share/deltacloud-core/bin/../lib/deltacloud/helpers/application_helper.rb:128:in `send' /usr/share/deltacloud-core/bin/../lib/deltacloud/helpers/application_helper.rb:128:in `instance_action' /usr/share/deltacloud-core/bin/../server.rb:475 /usr/share/deltacloud-core/bin/../lib/sinatra/rabbit.rb:125:in `instance_eval' /usr/share/deltacloud-core/bin/../lib/sinatra/rabbit.rb:125:in `POST /api/instances/:id/start' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:1057:in `call' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:1057:in `compile!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:643:in `instance_eval' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:643:in `route_eval' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:627:in `route!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:675:in `process_route' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:672:in `catch' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:672:in `process_route' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:626:in `route!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:625:in `each' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:625:in `route!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:760:in `dispatch!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:553:in `call!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:725:in `instance_eval' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:725:in `invoke' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:725:in `catch' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:725:in `invoke' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:553:in `call!' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:538:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_syslog.rb:48:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_date.rb:31:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_accept.rb:149:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_driver_select.rb:45:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_matrix_params.rb:102:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_runtime.rb:36:in `call' /usr/share/deltacloud-core/bin/../lib/sinatra/rack_etag.rb:41:in `call' /usr/lib/ruby/gems/1.8/gems/rack-accept-0.4.3/lib/rack/accept/context.rb:22: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/sinatra-1.1.2/lib/sinatra/base.rb:1167:in `call' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:1193:in `synchronize' /usr/lib/ruby/gems/1.8/gems/sinatra-1.1.2/lib/sinatra/base.rb:1167: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/eventmachine-0.12.10/lib/eventmachine.rb:1060:in `call' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1060:in `spawn_threadpool' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1057:in `initialize' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1057:in `new' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1057:in `spawn_threadpool' /usr/lib/ruby/gems/1.8/gems/eventmachine-0.12.10/lib/eventmachine.rb:1049:in `defer' /usr/lib/ruby/gems/1.8/gems/thin-1.2.11/lib/thin/connection.rb:54: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/share/deltacloud-core/bin/deltacloudd:223 /usr/bin/deltacloudd:5:in `load' /usr/bin/deltacloudd:5 /usr/bin/deltacloudd[24564]: Completed in 0.000000 | 0.000000 | 400 | application/xml | http://localhost:3002/api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c/start /usr/bin/deltacloudd[24564]: 127.0.0.1 - - [06/Oct/2011 18:40:04] "POST /api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c/start HTTP/1.1" 400 191 0.8439 /usr/bin/deltacloudd[24564]: Processing /api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c (for 127.0.0.1 at Thu Oct 06 18:40:04 -0400 2011) [GET] [RHEVM] /usr/bin/deltacloudd[24564]: Parameters: {} /usr/bin/deltacloudd[24564]: Provider: https://rhevm30.virt.bos.redhat.com:8443/api /usr/bin/deltacloudd[24564]: Authentication: Basic /usr/bin/deltacloudd[24564]: Server: thin 1.2.11 codename Bat-Shit Crazy /usr/bin/deltacloudd[24564]: Accept: application/xml /usr/bin/deltacloudd[24564]: Completed in 0.344318 | 0.000000 | 200 | application/xml | http://localhost:3002/api/instances/ccf602f7-7ef7-476e-857a-f205956ba95c [root@qeblade5 ~]# rpm -qa | egrep 'deltacloud|aeolus' deltacloud-core-ec2-0.5.0-0.2.1317167702git.fc15.noarch rubygem-aeolus-image-0.1.0-3.20111003170706git8f23238.fc15.noarch aeolus-conductor-0.4.0-0.20111005200518gitf9deb7f.fc15.noarch rubygem-deltacloud-client-0.4.0-3.fc15.noarch deltacloud-core-vsphere-0.5.0-0.2.1317167702git.fc15.noarch deltacloud-core-rhevm-0.5.0-0.2.1317167702git.fc15.noarch rubygem-aeolus-cli-0.1.0-3.20111003133323git9451323.fc15.noarch aeolus-conductor-doc-0.4.0-0.20111005200518gitf9deb7f.fc15.noarch aeolus-all-0.4.0-0.20111005200518gitf9deb7f.fc15.noarch deltacloud-core-0.5.0-0.2.1317167702git.fc15.noarch aeolus-configure-2.0.2-4.20111005095819gitaf7e59a.fc15.noarch aeolus-conductor-daemons-0.4.0-0.20111005200518gitf9deb7f.fc15.noarch So dbomatic continues to try to start the instance from its 'stopped' condition. One bug is that it tries forever to start the instance. However the bug here is that it calls 'start' on the instance and DC gives the backtrace above. The error doesn't seem to be reported to dbomatic/taskomatic/deltacloud client and the instance fails to start. *** This bug has been marked as a duplicate of bug 744289 *** removing bugs from tracker as part of 0.6 release |