Cinder

Image Volume Cache Feature is failing in master branch

Bug #1540761 reported by Bharath kumar
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
Cinder
Invalid
Undecided
Unassigned

Bug Description

When the image volume cache is enabled in the cinder , im getting the error saying Logical volume in volume group is already exists ,
Here is my c-vol log:

Stderr: u' Logical volume "volume-090dee62-d674-4ee4-9240-b0656eddbc51" already exists in volume group "stack-volumes-lvmdriver-1"\n' from (pid=6774) _reschedule /opt/stack/cinder/cinder/volume/flows/manager/create_volume.py:142
2016-02-02 11:46:16.629 DEBUG oslo_messaging._drivers.amqpdriver [req-63043350-1912-44d1-b4fe-8949f4fc69ae db103f84585d4fb2bfc0af60ac6c3b52 04994766d4354227985eb3519804e983] CAST unique_id: 10f1a0a51df74c50b97e279d24967bb2 exchange 'openstack' topic 'cinder-scheduler' from (pid=6774) _send /usr/local/lib/python2.7/dist-packages/oslo_messaging/_drivers/amqpdriver.py:448
2016-02-02 11:46:16.631 DEBUG cinder.volume.flows.manager.create_volume [req-63043350-1912-44d1-b4fe-8949f4fc69ae db103f84585d4fb2bfc0af60ac6c3b52 04994766d4354227985eb3519804e983] Volume 090dee62-d674-4ee4-9240-b0656eddbc51: re-scheduled from (pid=6774) _post_reschedule /opt/stack/cinder/cinder/volume/flows/manager/create_volume.py:156
2016-02-02 11:46:16.632 WARNING cinder.volume.manager [req-63043350-1912-44d1-b4fe-8949f4fc69ae db103f84585d4fb2bfc0af60ac6c3b52 04994766d4354227985eb3519804e983] Task 'cinder.volume.flows.manager.create_volume.OnFailureRescheduleTask;volume:create' (2f5df34a-8580-45bf-8d0c-ced41015681f) transitioned into state 'REVERTED' from state 'REVERTING' with result 'True'
2016-02-02 11:46:16.633 DEBUG cinder.volume.manager [req-63043350-1912-44d1-b4fe-8949f4fc69ae db103f84585d4fb2bfc0af60ac6c3b52 04994766d4354227985eb3519804e983] Task 'cinder.volume.flows.manager.create_volume.ExtractVolumeRefTask;volume:create' (e6f8c0e3-71cb-4929-99cb-bc047ac1d8d6) transitioned into state 'REVERTING' from state 'SUCCESS' from (pid=6774) _task_receiver /usr/local/lib/python2.7/dist-packages/taskflow/listeners/logging.py:189
2016-02-02 11:46:16.634 WARNING cinder.volume.manager [req-63043350-1912-44d1-b4fe-8949f4fc69ae db103f84585d4fb2bfc0af60ac6c3b52 04994766d4354227985eb3519804e983] Task 'cinder.volume.flows.manager.create_volume.ExtractVolumeRefTask;volume:create' (e6f8c0e3-71cb-4929-99cb-bc047ac1d8d6) transitioned into state 'REVERTED' from state 'REVERTING' with result 'None'
2016-02-02 11:46:16.636 WARNING cinder.volume.manager [req-63043350-1912-44d1-b4fe-8949f4fc69ae db103f84585d4fb2bfc0af60ac6c3b52 04994766d4354227985eb3519804e983] Flow 'volume_create_manager' (fd7a489b-279e-4566-9134-a7da3882091e) transitioned into state 'REVERTED' from state 'RUNNING'
2016-02-02 11:46:16.636 ERROR oslo_messaging.rpc.dispatcher [req-63043350-1912-44d1-b4fe-8949f4fc69ae db103f84585d4fb2bfc0af60ac6c3b52 04994766d4354227985eb3519804e983] Exception during message handling: Unexpected error while running command.
Command: None
Exit code: -
Stdout: u'Unexpected error while running command.\nCommand: sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvcreate -n volume-090dee62-d674-4ee4-9240-b0656eddbc51 stack-volumes-lvmdriver-1 -L 1g\nExit code: 5\nStdout: u\'\'\nStderr: u\' Logical volume "volume-090dee62-d674-4ee4-9240-b0656eddbc51" already exists in volume group "stack-volumes-lvmdriver-1"\\n\''
Stderr: None
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher Traceback (most recent call last):
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 142, in _dispatch_and_reply
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher executor_callback))
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 186, in _dispatch
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher executor_callback)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 129, in _do_dispatch
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher result = func(ctxt, **new_args)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/osprofiler/profiler.py", line 105, in wrapper
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher return f(*args, **kwargs)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/opt/stack/cinder/cinder/volume/manager.py", line 558, in create_volume
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher _run_flow()
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/opt/stack/cinder/cinder/volume/manager.py", line 545, in _run_flow
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher flow_engine.run()
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/taskflow/engines/action_engine/engine.py", line 159, in run
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher for _state in self.run_iter():
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/taskflow/engines/action_engine/engine.py", line 223, in run_iter
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher failure.Failure.reraise_if_any(it)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/taskflow/types/failure.py", line 292, in reraise_if_any
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher failures[0].reraise()
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/taskflow/types/failure.py", line 299, in reraise
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher six.reraise(*self._exc_info)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/taskflow/engines/action_engine/executor.py", line 82, in _execute_task
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher result = task.execute(**arguments)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/opt/stack/cinder/cinder/volume/flows/manager/create_volume.py", line 834, in execute
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher **volume_spec)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/opt/stack/cinder/cinder/volume/flows/manager/create_volume.py", line 769, in _create_from_image
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher image_service
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/opt/stack/cinder/cinder/volume/flows/manager/create_volume.py", line 645, in _create_from_image_download
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher model_update = self.driver.create_volume(volume_ref)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/osprofiler/profiler.py", line 105, in wrapper
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher return f(*args, **kwargs)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/opt/stack/cinder/cinder/volume/drivers/lvm.py", line 334, in create_volume
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher mirror_count)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/opt/stack/cinder/cinder/volume/drivers/lvm.py", line 170, in _create_volume
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher vg_ref.create_volume(name, size, lvm_type, mirror_count)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/opt/stack/cinder/cinder/brick/local_dev/lvm.py", line 555, in create_volume
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher run_as_root=True)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/opt/stack/cinder/cinder/utils.py", line 154, in execute
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher return processutils.execute(*cmd, **kwargs)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_concurrency/processutils.py", line 312, in execute
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher cmd=sanitized_cmd)
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher ProcessExecutionError: Unexpected error while running command.
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher Command: sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvcreate -n volume-090dee62-d674-4ee4-9240-b0656eddbc51 stack-volumes-lvmdriver-1 -L 1g
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher Exit code: 5
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher Stdout: u''
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher Stderr: u' Logical volume "volume-090dee62-d674-4ee4-9240-b0656eddbc51" already exists in volume group "stack-volumes-lvmdriver-1"\n'
2016-02-02 11:46:16.636 TRACE oslo_messaging.rpc.dispatcher

See original description
Bharath kumar (bharath-kumar3)
description: updated
Revision history for this message
Patrick East (patrick-east) wrote :

Tested with latest master (HEAD = 9814feedf46e9d363cefb975ca994b83cf89cba9) on devstack with LVM and Pure iSCSI drivers. Was not able to reproduce the issue.

Revision history for this message
Patrick East (patrick-east) wrote :

Confirmed with bkumar that updating to the latest code resolves the issue.

Changed in cinder:
status: New → Invalid
Eric Harney (eharney)
tags: removed: cinder devstack
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.
Subscribing...

Other bug subscribers

Remote bug watches

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