OpenStack Compute (nova)

Bug #1416269
Comment #3

Comment 3 for bug 1416269

Revision history for this message

Prachi Khatri (prachikhatri-18) wrote on 2015-02-09:

Hi Jerry, thanks for your inputs. I have tried on kilo version and able to see the "block device mapping is invalid" error while booting vm with attaching cinder volume.I am copying the log, got with cinder, however there is no error logs with nova.

log from cinder:
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/opt/stack/python-keystoneclient/keystoneclient/middleware/auth_token.py", line 615, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault return self.app(env, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 144, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault return resp(environ, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 144, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault return resp(environ, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/lib/python2.7/dist-packages/routes/middleware.py", line 131, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault response = self.app(environ, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 144, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault return resp(environ, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 130, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault resp = self.call_func(req, *args, **self.kwargs)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 195, in call_func
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault return self.func(req, *args, **kwargs)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/opt/stack/cinder/cinder/api/openstack/wsgi.py", line 895, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault content_type, body, accept)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/opt/stack/cinder/cinder/api/openstack/wsgi.py", line 943, in _process_stack
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault action_result = self.dispatch(meth, request, action_args)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/opt/stack/cinder/cinder/api/openstack/wsgi.py", line 1019, in dispatch
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault return method(req=request, **action_args)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/opt/stack/cinder/cinder/api/contrib/volume_actions.py", line 195, in _initialize_connection
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault connector)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/opt/stack/cinder/cinder/volume/api.py", line 75, in wrapped
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault return func(self, context, target_obj, *args, **kwargs)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/opt/stack/cinder/cinder/volume/api.py", line 423, in initialize_connection
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault connector)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/opt/stack/cinder/cinder/volume/rpcapi.py", line 120, in initialize_connection
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault connector=connector)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/rpc/client.py", line 150, in call
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault wait_for_reply=True, timeout=timeout)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/transport.py", line 90, in _send
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault timeout=timeout)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 412, in send
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault return self._send(target, ctxt, message, wait_for_reply, timeout)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 405, in _send
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault raise result
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault OSError: [Errno 17] File exists
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault
2015-02-09 14:18:26.283 INFO cinder.api.middleware.fault [req-b695dc90-c515-44fa-a2e5-ddaf386bcc69 7a9a1846bdef4c469eb02dbec4a8461e 5a22aaf57cad4e81991c55efdfbb93f2] http://172.16.73.159:8776/v1/5a22aaf57cad4e81991c55efdfbb93f2/volumes/084eedd4-421d-4dbc-a674-1e2405953b58/action returned with HTTP 500
2015-02-09 14:18:26.283 INFO eventlet.wsgi.server [req-b695dc90-c515-44fa-a2e5-ddaf386bcc69 7a9a1846bdef4c469eb02dbec4a8461e 5a22aaf57cad4e81991c55efdfbb93f2] 172.16.73.159 - - [09/Feb/2015 14:18:26] "POST /v1/5a22aaf57cad4e81991c55efdfbb93f2/volumes/084eedd4-421d-4dbc-a674-1e2405953b58/action HTTP/1.1" 500 401 0.045225

ubuntu@ubuntu-ThinkCentre-M92p:~/devstack$ nova boot --flavor m1.small --image 7146174f-9d25-45e7-a646-ff74b23e7ead --nic net-id=4545a373-43ff-4991-b5cd-d0ba5c352ab5 --block-device source=volume,dest=volume,bootindex=1,shutdown=remove,id=084eedd4-421d-4dbc-a674-1e2405953b58 test_with_cinder --poll
+--------------------------------------+------------------------------------------------------------------+
| Property                             | Value                                                            |
+--------------------------------------+------------------------------------------------------------------+
| OS-DCF:diskConfig                    | MANUAL                                                           |
| OS-EXT-AZ:availability_zone          | nova                                                             |
| OS-EXT-STS:power_state               | 0                                                                |
| OS-EXT-STS:task_state                | scheduling                                                       |
| OS-EXT-STS:vm_state                  | building                                                         |
| OS-SRV-USG:launched_at               | -                                                                |
| OS-SRV-USG:terminated_at             | -                                                                |
| accessIPv4                           |                                                                  |
| accessIPv6                           |                                                                  |
| adminPass                            | c8dPc3NzmBPf                                                     |
| config_drive                         |                                                                  |
| created                              | 2015-02-09T08:48:15Z                                             |
| flavor                               | m1.small (2)                                                     |
| hostId                               |                                                                  |
| id                                   | dd1907b7-d8b5-4a38-94d3-01ab05bb89af                             |
| image                                | cirros-0.3.2-x86_64-disk1 (7146174f-9d25-45e7-a646-ff74b23e7ead) |
| key_name                             | -                                                                |
| metadata                             | {}                                                               |
| name                                 | test_with_cinder                                                 |
| os-extended-volumes:volumes_attached | [{"id": "084eedd4-421d-4dbc-a674-1e2405953b58"}]                 |
| progress                             | 0                                                                |
| security_groups                      | default                                                          |
| status                               | BUILD                                                            |
| tenant_id                            | 5a22aaf57cad4e81991c55efdfbb93f2                                 |
| updated                              | 2015-02-09T08:48:16Z                                             |
| user_id                              | 7a9a1846bdef4c469eb02dbec4a8461e                                 |
+--------------------------------------+------------------------------------------------------------------+
Server building... 0% complete
Error building server
ERROR (InstanceInErrorState): Block Device Mapping is Invalid.

log from cinder:
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/opt/stack/python-keystoneclient/keystoneclient/middleware/auth_token.py", line 615, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     return self.app(env, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 144, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     return resp(environ, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 144, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     return resp(environ, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/lib/python2.7/dist-packages/routes/middleware.py", line 131, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     response = self.app(environ, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 144, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     return resp(environ, start_response)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 130, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     resp = self.call_func(req, *args, **self.kwargs)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/lib/python2.7/dist-packages/webob/dec.py", line 195, in call_func
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     return self.func(req, *args, **kwargs)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/opt/stack/cinder/cinder/api/openstack/wsgi.py", line 895, in __call__
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     content_type, body, accept)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/opt/stack/cinder/cinder/api/openstack/wsgi.py", line 943, in _process_stack
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     action_result = self.dispatch(meth, request, action_args)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/opt/stack/cinder/cinder/api/openstack/wsgi.py", line 1019, in dispatch
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     return method(req=request, **action_args)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/opt/stack/cinder/cinder/api/contrib/volume_actions.py", line 195, in _initialize_connection
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     connector)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/opt/stack/cinder/cinder/volume/api.py", line 75, in wrapped
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     return func(self, context, target_obj, *args, **kwargs)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/opt/stack/cinder/cinder/volume/api.py", line 423, in initialize_connection
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     connector)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/opt/stack/cinder/cinder/volume/rpcapi.py", line 120, in initialize_connection
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     connector=connector)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/rpc/client.py", line 150, in call
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     wait_for_reply=True, timeout=timeout)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/transport.py", line 90, in _send
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     timeout=timeout)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 412, in send
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     return self._send(target, ctxt, message, wait_for_reply, timeout)
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault   File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 405, in _send
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault     raise result
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault OSError: [Errno 17] File exists
2015-02-09 14:18:26.282 TRACE cinder.api.middleware.fault
2015-02-09 14:18:26.283 INFO cinder.api.middleware.fault [req-b695dc90-c515-44fa-a2e5-ddaf386bcc69 7a9a1846bdef4c469eb02dbec4a8461e 5a22aaf57cad4e81991c55efdfbb93f2] http://172.16.73.159:8776/v1/5a22aaf57cad4e81991c55efdfbb93f2/volumes/084eedd4-421d-4dbc-a674-1e2405953b58/action returned with HTTP 500
2015-02-09 14:18:26.283 INFO eventlet.wsgi.server [req-b695dc90-c515-44fa-a2e5-ddaf386bcc69 7a9a1846bdef4c469eb02dbec4a8461e 5a22aaf57cad4e81991c55efdfbb93f2] 172.16.73.159 - - [09/Feb/2015 14:18:26] "POST /v1/5a22aaf57cad4e81991c55efdfbb93f2/volumes/084eedd4-421d-4dbc-a674-1e2405953b58/action HTTP/1.1" 500 401 0.045225