Created attachment 933322 [details] vdsm log Description of problem: Try to export a VM which its disks are based on Template (Thin provisioned) and with no collapse snapshot Getting [1] in VDSM log (while the Template is contained in the export domain). When the Template does not contained in the export domain we get the [2] in VDSM [1] 4fafa/images/728c6008-6870-4cb3-858d-b3ca7e4bdb70/471b7ebd-0d3b-43b9-bd37-35a1785f741e f80f8811-894e-46e0-a4ee-4a9acceb2dec::ERROR::2014-09-01 14:36:05,648::task::866::Storage.TaskManager.Task::(_setError) Task=`f80f8811-894e-46e0-a4ee-4a9acceb2dec`::Unexpected error Traceback (most recent call last): File "/usr/share/vdsm/storage/task.py", line 873, in _run return fn(*args, **kargs) File "/usr/share/vdsm/storage/task.py", line 403, in run return function(self.task, *argslist) File "/usr/share/vdsm/storage/fileVolume.py", line 239, in shareVolumeRollback procPool.utils.rmFile(volPath) AttributeError: '_IOProcWrapper' object has no attribute 'utils' f80f8811-894e-46e0-a4ee-4a9acceb2dec::DEBUG::2014-09-01 14:36:05,648::task::885::Storage.TaskManager.Task::(_run) Task=`f80f8811-894e-46e0-a4ee-4a9acceb2dec`::Task._run: f80f8811-894e-46e0-a4ee-4a9acceb2dec () {} failed - stopping task f80f8811-894e-46e0-a4ee-4a9acceb2dec::DEBUG::2014-09-01 14:36:05,648::task::1217::Storage.TaskManager.Task::(stop) Task=`f80f8811-894e-46e0-a4ee-4a9acceb2dec`::stopping in state recovering (force False) f80f8811-894e-46e0-a4ee-4a9acceb2dec::DEBUG::2014-09-01 14:36:05,648::task::993::Storage.TaskManager.Task::(_decref) Task=`f80f8811-894e-46e0-a4ee-4a9acceb2dec`::ref 1 aborting True f80f8811-894e-46e0-a4ee-4a9acceb2dec::WARNING::2014-09-01 14:36:05,649::task::811::Storage.TaskManager.Task::(_recover) Task=`f80f8811-894e-46e0-a4ee-4a9acceb2dec`::task f80f8811-894e-46e0-a4ee-4a9acceb2dec: recovery failed: Task is abort ed: u"'_IOProcWrapper' object has no attribute 'utils'" - code 100 Traceback (most recent call last): File "/usr/share/vdsm/storage/task.py", line 808, in _recover self._run(rec.run) File "/usr/share/vdsm/storage/task.py", line 887, in _run raise se.TaskAborted(message, code) TaskAborted: Task is aborted: u"'_IOProcWrapper' object has no attribute 'utils'" - code 100 f80f8811-894e-46e0-a4ee-4a9acceb2dec::DEBUG::2014-09-01 14:36:05,649::task::595::Storage.TaskManager.Task::(_updateState) Task=`f80f8811-894e-46e0-a4ee-4a9acceb2dec`::moving from state recovering -> state raborting [2] Thread-25::DEBUG::2014-09-01 14:31:53,639::__init__::225::IOProcess::(_processLogs) DEBUG|(70684) Building responseDEBUG|(70684) Queuing responseDEBUG|Sending response sized 95 Thread-53::ERROR::2014-09-01 14:31:53,640::task::866::Storage.TaskManager.Task::(_setError) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::Unexpected error Traceback (most recent call last): File "/usr/share/vdsm/storage/task.py", line 873, in _run return fn(*args, **kargs) File "/usr/share/vdsm/logUtils.py", line 45, in wrapper res = f(*args, **kwargs) File "/usr/share/vdsm/storage/hsm.py", line 1608, in moveImage ).createFakeTemplate(dstDom.sdUUID, tParams) File "/usr/share/vdsm/storage/image.py", line 242, in createFakeTemplate volParams['volUUID']) File "/usr/share/vdsm/storage/fileVolume.py", line 58, in __init__ volume.Volume.__init__(self, repoPath, sdUUID, imgUUID, volUUID) File "/usr/share/vdsm/storage/volume.py", line 144, in __init__ self.validate() File "/usr/share/vdsm/storage/volume.py", line 156, in validate self.validateImagePath() File "/usr/share/vdsm/storage/fileVolume.py", line 487, in validateImagePath if not self.oop.os.path.isdir(imageDir): File "/usr/share/vdsm/storage/outOfProcess.py", line 251, in isdir res = self._iop.stat(path) File "/usr/lib/python2.6/site-packages/ioprocess/__init__.py", line 367, in stat resdict = self._sendCommand("stat", {"path": path}, self.timeout) File "/usr/lib/python2.6/site-packages/ioprocess/__init__.py", line 344, in _sendCommand raise OSError(errcode, errstr) OSError: [Errno 2] No such file or directory Thread-53::DEBUG::2014-09-01 14:31:53,640::task::885::Storage.TaskManager.Task::(_run) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::Task._run: f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe ('3307f387-262b-4e17-a3f2-a5f0da460a62', '97ce0862-80f1-48 6d-aad0-a8082fffbad2', '3934c895-31cc-477b-bdc2-2eda1dc4fafa', '728c6008-6870-4cb3-858d-b3ca7e4bdb70', '', 1, 'false', 'false') {} failed - stopping task Thread-53::DEBUG::2014-09-01 14:31:53,641::task::1217::Storage.TaskManager.Task::(stop) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::stopping in state preparing (force False) Thread-53::DEBUG::2014-09-01 14:31:53,641::task::993::Storage.TaskManager.Task::(_decref) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::ref 1 aborting True Thread-53::INFO::2014-09-01 14:31:53,641::task::1171::Storage.TaskManager.Task::(prepare) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::aborting: Task is aborted: u'[Errno 2] No such file or directory' - code 100 Thread-53::DEBUG::2014-09-01 14:31:53,641::task::1176::Storage.TaskManager.Task::(prepare) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::Prepare: aborted: [Errno 2] No such file or directory Thread-53::DEBUG::2014-09-01 14:31:53,641::task::993::Storage.TaskManager.Task::(_decref) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::ref 0 aborting True Thread-53::DEBUG::2014-09-01 14:31:53,641::task::928::Storage.TaskManager.Task::(_doAbort) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::Task._doAbort: force False Thread-53::DEBUG::2014-09-01 14:31:53,642::resourceManager::977::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-53::DEBUG::2014-09-01 14:31:53,642::task::595::Storage.TaskManager.Task::(_updateState) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::moving from state preparing -> state aborting Thread-53::DEBUG::2014-09-01 14:31:53,642::task::550::Storage.TaskManager.Task::(__state_aborting) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::_aborting: recover policy none Thread-53::DEBUG::2014-09-01 14:31:53,642::task::595::Storage.TaskManager.Task::(_updateState) Task=`f1fd3aca-d5ee-4c73-ad2e-6dadff77abfe`::moving from state aborting -> state failed Thread-53::DEBUG::2014-09-01 14:31:53,642::resourceManager::940::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-53::DEBUG::2014-09-01 14:31:53,642::resourceManager::977::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-53::ERROR::2014-09-01 14:31:53,642::dispatcher::79::Storage.Dispatcher::(wrapper) [Errno 2] No such file or directory Traceback (most recent call last): File "/usr/share/vdsm/storage/dispatcher.py", line 71, in wrapper result = ctask.prepare(func, *args, **kwargs) File "/usr/share/vdsm/storage/task.py", line 103, in wrapper return m(self, *a, **kw) File "/usr/share/vdsm/storage/task.py", line 1179, in prepare raise self.error OSError: [Errno 2] No such file or directory Thread-85::DEBUG::2014-09-01 14:31:53,773::BindingXMLRPC::319::vds::(wrapper) client [10.35.1.127] Version-Release number of selected component (if applicable): How reproducible: 100% Steps to Reproduce: 1. Create a VM based on Template 2. Try to export the VM (It reproduced even if the Template is in the Export Domain and also if it doesn't) 3. Actual results: The export of the VM fails Expected results: The export should succeed Additional info: VM can only be exported when marking "Collapse snapshot"
Created attachment 933323 [details] engine log
seems like an issue related to IO process based on the error: '_IOProcWrapper' object has no attribute 'utils'
*** This bug has been marked as a duplicate of bug 1120721 ***