Blame SOURCES/BZ-1335250-fssnapshot-handle-lvm-errors.patch

d2a170
diff -up yum-3.4.3/yumcommands.py.orig yum-3.4.3/yumcommands.py
d2a170
--- yum-3.4.3/yumcommands.py.orig	2016-07-21 11:39:40.422379800 +0200
d2a170
+++ yum-3.4.3/yumcommands.py	2016-07-21 11:40:42.144992126 +0200
d2a170
@@ -42,6 +42,7 @@ import errno
d2a170
 import yum.config
d2a170
 from yum import updateinfo
d2a170
 from yum.packages import parsePackages
d2a170
+from yum.fssnapshots import LibLVMError, lvmerr2str
d2a170
 
d2a170
 def _err_mini_usage(base, basecmd):
d2a170
     if basecmd not in base.yum_cli_commands:
d2a170
@@ -4266,12 +4267,19 @@ class FSSnapshotCommand(YumCommand):
d2a170
             return 1, [basecmd + ' ' + subcommand + ' done']
d2a170
 
d2a170
         if subcommand == 'list':
d2a170
-            snaps = base.fssnap.old_snapshots()
d2a170
+            try:
d2a170
+                snaps = base.fssnap.old_snapshots()
d2a170
+            except LibLVMError as e:
d2a170
+                return 1, [_("Failed to list snapshots: ") + lvmerr2str(e)]
d2a170
             print _("List of %u snapshosts:") % len(snaps)
d2a170
             self._li_snaps(base, snaps)
d2a170
 
d2a170
         if subcommand == 'delete':
d2a170
-            snaps = base.fssnap.old_snapshots()
d2a170
+            msg = _("Failed to delete snapshots: ")
d2a170
+            try:
d2a170
+                snaps = base.fssnap.old_snapshots()
d2a170
+            except LibLVMError as e:
d2a170
+                return 1, [msg + lvmerr2str(e)]
d2a170
             devs = [x['dev'] for x in snaps]
d2a170
             snaps = set()
d2a170
             for dev in devs:
d2a170
@@ -4282,13 +4290,20 @@ class FSSnapshotCommand(YumCommand):
d2a170
                     if dev == extcmd or fnmatch.fnmatch(dev, extcmd):
d2a170
                         snaps.add(dev)
d2a170
                         break
d2a170
-            snaps = base.fssnap.del_snapshots(devices=snaps)
d2a170
+            try:
d2a170
+                snaps = base.fssnap.del_snapshots(devices=snaps)
d2a170
+            except LibLVMError as e:
d2a170
+                return 1, [msg + lvmerr2str(e)]
d2a170
             print _("Deleted %u snapshosts:") % len(snaps)
d2a170
             self._li_snaps(base, snaps)
d2a170
 
d2a170
         if subcommand in ('have-space', 'has-space'):
d2a170
             pc = base.conf.fssnap_percentage
d2a170
-            if base.fssnap.has_space(pc):
d2a170
+            try:
d2a170
+                has_space = base.fssnap.has_space(pc)
d2a170
+            except LibLVMError as e:
d2a170
+                return 1, [_("Could not determine free space on logical volumes: ") + lvmerr2str(e)]
d2a170
+            if has_space:
d2a170
                 print _("Space available to take a snapshot.")
d2a170
             else:
d2a170
                 print _("Not enough space available on logical volumes to take a snapshot.")
d2a170
@@ -4296,14 +4311,22 @@ class FSSnapshotCommand(YumCommand):
d2a170
         if subcommand == 'create':
d2a170
             tags = {'*': ['reason=manual']}
d2a170
             pc = base.conf.fssnap_percentage
d2a170
-            snaps = base.fssnap.snapshot(pc, tags=tags)
d2a170
+            msg = _("Failed to create snapshots")
d2a170
+            try:
d2a170
+                snaps = base.fssnap.snapshot(pc, tags=tags)
d2a170
+            except LibLVMError as e:
d2a170
+                msg += ": " + lvmerr2str(e)
d2a170
+                snaps = []
d2a170
             if not snaps:
d2a170
-                print _("Failed to create snapshots")
d2a170
+                print msg
d2a170
             for (odev, ndev) in snaps:
d2a170
                 print _("Created snapshot from %s, results is: %s") %(odev,ndev)
d2a170
 
d2a170
         if subcommand == 'summary':
d2a170
-            snaps = base.fssnap.old_snapshots()
d2a170
+            try:
d2a170
+                snaps = base.fssnap.old_snapshots()
d2a170
+            except LibLVMError as e:
d2a170
+                return 1, [_("Failed to list snapshots: ") + lvmerr2str(e)]
d2a170
             if not snaps:
d2a170
                 print _("No snapshots, LVM version:"), base.fssnap.version
d2a170
                 return 0, [basecmd + ' ' + subcommand + ' done']
d2a170
diff -up yum-3.4.3/yum/fssnapshots.py.orig yum-3.4.3/yum/fssnapshots.py
d2a170
--- yum-3.4.3/yum/fssnapshots.py.orig	2016-07-21 11:39:40.351380246 +0200
d2a170
+++ yum-3.4.3/yum/fssnapshots.py	2016-07-21 11:40:02.211242946 +0200
d2a170
@@ -6,6 +6,7 @@ import time
d2a170
 from datetime import datetime
d2a170
 
d2a170
 import subprocess
d2a170
+from yum import _
d2a170
 
d2a170
 try:
d2a170
     import lvm
d2a170
@@ -24,6 +25,14 @@ except:
d2a170
     lvm = None
d2a170
     _ver = None
d2a170
 
d2a170
+if lvm is not None:
d2a170
+    from lvm import LibLVMError
d2a170
+    class _ResultError(LibLVMError):
d2a170
+        """Exception raised for LVM calls resulting in bad return values."""
d2a170
+        pass
d2a170
+else:
d2a170
+    LibLVMError = None
d2a170
+
d2a170
 
d2a170
 def _is_origin(lv):
d2a170
     snap = lv.getAttr()
d2a170
@@ -53,14 +62,18 @@ def _vg_name2lv(vg, lvname):
d2a170
         return None
d2a170
 
d2a170
 def _list_vg_names():
d2a170
-    names = lvm.listVgNames()
d2a170
+    try:
d2a170
+        names = lvm.listVgNames()
d2a170
+    except LibLVMError:
d2a170
+        # Try to use the lvm binary instead
d2a170
+        names = []
d2a170
 
d2a170
     if not names: # Could be just broken...
d2a170
         p = subprocess.Popen(["/sbin/lvm", "vgs", "-o", "vg_name"],
d2a170
                              stdout=subprocess.PIPE, stderr=subprocess.PIPE)
d2a170
         err = p.wait()
d2a170
         if err:
d2a170
-            return [] # Meh.
d2a170
+            raise _ResultError(_("Failed to obtain volume group names"))
d2a170
 
d2a170
         output = p.communicate()[0]
d2a170
         output = output.split('\n')
d2a170
@@ -132,6 +145,25 @@ def _lv_data(vg, lv):
d2a170
 
d2a170
     return data
d2a170
 
d2a170
+def _log_traceback(func):
d2a170
+    """Decorator for _FSSnap methods that logs LVM tracebacks."""
d2a170
+    def wrap(self, *args, **kwargs):
d2a170
+        try:
d2a170
+            return func(self, *args, **kwargs)
d2a170
+        except LibLVMError as e:
d2a170
+            if self._logger is not None:
d2a170
+                self._logger.exception(e)
d2a170
+            raise
d2a170
+    return wrap
d2a170
+
d2a170
+def lvmerr2str(exc):
d2a170
+    """Convert a LibLVMError instance to a readable error message."""
d2a170
+    if type(exc) == LibLVMError and len(exc.args) == 2:
d2a170
+        # args[0] is the error number so ignore that
d2a170
+        return exc.args[1]
d2a170
+    else:
d2a170
+        return str(exc)
d2a170
+
d2a170
 
d2a170
 class _FSSnap(object):
d2a170
 
d2a170
@@ -139,7 +171,7 @@ class _FSSnap(object):
d2a170
     # New style is: fedora/root fedora/swap
d2a170
     # New style is: redhat/root redhat/swap
d2a170
     def __init__(self, root="/", lookup_mounts=True,
d2a170
-                 devices=('!*/swap', '!*/lv_swap')):
d2a170
+                 devices=('!*/swap', '!*/lv_swap'), logger=None):
d2a170
         if not lvm or os.geteuid():
d2a170
             devices = []
d2a170
 
d2a170
@@ -150,12 +182,18 @@ class _FSSnap(object):
d2a170
         self._postfix = None
d2a170
         self._root = root
d2a170
         self._devs = devices
d2a170
-        self._vgnames = []
d2a170
+        self._vgname_list = None
d2a170
+        # Logger object to be used for LVM traceback logging
d2a170
+        self._logger = logger
d2a170
 
d2a170
         if not self._devs:
d2a170
             return
d2a170
 
d2a170
-        self._vgnames = _list_vg_names() if self.available else []
d2a170
+    @property
d2a170
+    def _vgnames(self):
d2a170
+        if self._vgname_list is None:
d2a170
+            self._vgname_list = _list_vg_names() if self.available else []
d2a170
+        return self._vgname_list
d2a170
 
d2a170
     def _use_dev(self, vgname, lv=None):
d2a170
 
d2a170
@@ -196,6 +234,7 @@ class _FSSnap(object):
d2a170
 
d2a170
         return found_neg
d2a170
 
d2a170
+    @_log_traceback
d2a170
     def has_space(self, percentage=100):
d2a170
         """ See if we have enough space to try a snapshot. """
d2a170
 
d2a170
@@ -207,7 +246,8 @@ class _FSSnap(object):
d2a170
 
d2a170
             vg = lvm.vgOpen(vgname, 'r')
d2a170
             if not vg:
d2a170
-                return False
d2a170
+                raise _ResultError(
d2a170
+                    _("Unknown error when opening volume group ") + vgname)
d2a170
 
d2a170
             vgfsize = vg.getFreeSize()
d2a170
             lvssize = 0
d2a170
@@ -230,6 +270,7 @@ class _FSSnap(object):
d2a170
         return ret
d2a170
 
d2a170
 
d2a170
+    @_log_traceback
d2a170
     def snapshot(self, percentage=100, prefix='', postfix=None, tags={}):
d2a170
         """ Attempt to take a snapshot, note that errors can happen after
d2a170
             this function succeeds. """
d2a170
@@ -245,7 +286,8 @@ class _FSSnap(object):
d2a170
 
d2a170
             vg = lvm.vgOpen(vgname, 'w')
d2a170
             if not vg:
d2a170
-                return False
d2a170
+                raise _ResultError(
d2a170
+                    _("Unknown error when opening volume group ") + vgname)
d2a170
 
d2a170
             for lv in vg.listLVs():
d2a170
                 lvname = lv.getName()
d2a170
@@ -257,7 +299,8 @@ class _FSSnap(object):
d2a170
                 nlv = lv.snapshot(nlvname, (lv.getSize() * percentage) / 100)
d2a170
                 if not nlv: # Failed here ... continuing seems bad.
d2a170
                     vg.close()
d2a170
-                    return None
d2a170
+                    raise _ResultError(
d2a170
+                        _("Unknown error when creating snapshot ") + nlvname)
d2a170
 
d2a170
                 odev = "%s/%s" % (vgname,  lvname)
d2a170
                 ndev = "%s/%s" % (vgname, nlvname)
d2a170
@@ -280,6 +323,7 @@ class _FSSnap(object):
d2a170
 
d2a170
         return ret
d2a170
 
d2a170
+    @_log_traceback
d2a170
     def old_snapshots(self):
d2a170
         """ List data for old snapshots. """
d2a170
 
d2a170
@@ -289,6 +333,9 @@ class _FSSnap(object):
d2a170
             # see stuff after changing config. options.
d2a170
 
d2a170
             vg = lvm.vgOpen(vgname, 'w')
d2a170
+            if not vg:
d2a170
+                raise _ResultError(
d2a170
+                    _("Unknown error when opening volume group ") + vgname)
d2a170
 
d2a170
             for lv in vg.listLVs():
d2a170
 
d2a170
@@ -300,6 +347,7 @@ class _FSSnap(object):
d2a170
 
d2a170
         return ret
d2a170
 
d2a170
+    @_log_traceback
d2a170
     def del_snapshots(self, devices=[]):
d2a170
         """ Remove snapshots. """
d2a170
 
d2a170
@@ -318,6 +366,9 @@ class _FSSnap(object):
d2a170
 
d2a170
         for vgname in togo:
d2a170
             vg = lvm.vgOpen(vgname, 'w')
d2a170
+            if not vg:
d2a170
+                raise _ResultError(
d2a170
+                    _("Unknown error when opening volume group ") + vgname)
d2a170
 
d2a170
             for lvname in togo[vgname]:
d2a170
                 lv = _vg_name2lv(vg, lvname)
d2a170
diff -up yum-3.4.3/yum/__init__.py.orig yum-3.4.3/yum/__init__.py
d2a170
--- yum-3.4.3/yum/__init__.py.orig	2016-07-21 11:39:40.425379782 +0200
d2a170
+++ yum-3.4.3/yum/__init__.py	2016-07-21 11:40:02.211242946 +0200
d2a170
@@ -81,6 +81,7 @@ import yumRepo
d2a170
 import callbacks
d2a170
 import yum.history
d2a170
 import yum.fssnapshots
d2a170
+from yum.fssnapshots import LibLVMError, lvmerr2str
d2a170
 import yum.igroups
d2a170
 import update_md
d2a170
 
d2a170
@@ -204,6 +205,7 @@ class YumBase(depsolve.Depsolve):
d2a170
         self._not_found_i = {}
d2a170
         self.logger = logging.getLogger("yum.YumBase")
d2a170
         self.verbose_logger = logging.getLogger("yum.verbose.YumBase")
d2a170
+        self.file_logger = logging.getLogger("yum.filelogging.YumBase")
d2a170
         self._override_sigchecks = False
d2a170
         self._repos = RepoStorage(self)
d2a170
         self.repo_setopts = {} # since we have to use repo_setopts in base and 
d2a170
@@ -1048,7 +1050,8 @@ class YumBase(depsolve.Depsolve):
d2a170
         if self._fssnap is None:
d2a170
             devices = self.conf.fssnap_devices
d2a170
             self._fssnap = yum.fssnapshots._FSSnap(root=self.conf.installroot,
d2a170
-                                                   devices=devices)
d2a170
+                                                   devices=devices,
d2a170
+                                                   logger=self.file_logger)
d2a170
 
d2a170
         return self._fssnap
d2a170
 
d2a170
@@ -1726,6 +1729,37 @@ much more problems).
d2a170
         :raises: :class:`yum.Errors.YumRPMTransError` if there is a
d2a170
            transaction cannot be completed
d2a170
         """
d2a170
+
d2a170
+        def create_snapshot(post=False):
d2a170
+            """Create the pre or post trans snapshot if we have free space."""
d2a170
+            msg = _("Not enough space on logical volumes to create %s FS snapshot." %
d2a170
+                    ("post trans" if post else "pre."))
d2a170
+            try:
d2a170
+                has_space = self.fssnap.has_space(self.conf.fssnap_percentage)
d2a170
+            except LibLVMError as e:
d2a170
+                msg = _("Could not determine free space on logical volumes: ") + lvmerr2str(e)
d2a170
+                has_space = False
d2a170
+            if not has_space:
d2a170
+                if not post and self.conf.fssnap_abort_on_errors in ('snapshot-failure', 'any'):
d2a170
+                    raise Errors.YumRPMTransError(msg="Aborting transaction", errors=msg)
d2a170
+                else:
d2a170
+                    self.verbose_logger.critical(msg)
d2a170
+            else:
d2a170
+                tags = {'*': ['reason=automatic']} # FIXME: pre. and post tags
d2a170
+                msg = _("Failed to create snapshot")
d2a170
+                try:
d2a170
+                    snaps = self.fssnap.snapshot(self.conf.fssnap_percentage, tags=tags)
d2a170
+                except LibLVMError as e:
d2a170
+                    msg += ": " + lvmerr2str(e)
d2a170
+                    snaps = []
d2a170
+                if not snaps:
d2a170
+                    if not post and self.conf.fssnap_abort_on_errors in ('snapshot-failure', 'any'):
d2a170
+                        raise Errors.YumRPMTransError(msg="Aborting transaction", errors=msg)
d2a170
+                    else:
d2a170
+                        self.verbose_logger.critical(msg)
d2a170
+                for (odev, ndev) in snaps:
d2a170
+                    self.verbose_logger.info(_("Created snapshot from %s, results is: %s") % (odev, ndev))
d2a170
+
d2a170
         if (self.conf.fssnap_automatic_pre or self.conf.fssnap_automatic_post) and not self.fssnap.available:
d2a170
             msg = _("Snapshot support not available.")
d2a170
             if self.conf.fssnap_abort_on_errors in ('broken-setup', 'any'):
d2a170
@@ -1737,7 +1771,13 @@ much more problems).
d2a170
                                        self.conf.fssnap_automatic_post) and
d2a170
                                       self.conf.fssnap_automatic_keep):
d2a170
             # Automatically kill old snapshots...
d2a170
-            snaps = self.fssnap.old_snapshots()
d2a170
+            cleanup_fail = False
d2a170
+            try:
d2a170
+                snaps = self.fssnap.old_snapshots()
d2a170
+            except LibLVMError as e:
d2a170
+                self.verbose_logger.debug(lvmerr2str(e))
d2a170
+                cleanup_fail = True
d2a170
+                snaps = []
d2a170
             snaps = sorted(snaps, key=lambda x: (x['ctime'], x['origin_dev']),
d2a170
                            reverse=True)
d2a170
             last = '<n/a>'
d2a170
@@ -1754,30 +1794,22 @@ much more problems).
d2a170
                 if num > self.conf.fssnap_automatic_keep:
d2a170
                     todel.append(snap['dev'])
d2a170
             # Display something to the user?
d2a170
-            snaps = self.fssnap.del_snapshots(devices=todel)
d2a170
+            try:
d2a170
+                snaps = self.fssnap.del_snapshots(devices=todel)
d2a170
+            except LibLVMError as e:
d2a170
+                self.verbose_logger.debug(lvmerr2str(e))
d2a170
+                cleanup_fail = True
d2a170
+                snaps = []
d2a170
             if len(snaps):
d2a170
                 self.verbose_logger.info(_("Deleted %u snapshots.") % len(snaps))
d2a170
+            elif cleanup_fail:
d2a170
+                self.verbose_logger.warning(_("Skipping the cleanup of old "
d2a170
+                                              "snapshots due to errors"))
d2a170
 
d2a170
         if (self.fssnap.available and
d2a170
             (not self.ts.isTsFlagSet(rpm.RPMTRANS_FLAG_TEST) and
d2a170
             self.conf.fssnap_automatic_pre)):
d2a170
-            if not self.fssnap.has_space(self.conf.fssnap_percentage):
d2a170
-                msg = _("Not enough space on logical volumes to create pre. FS snapshot.")
d2a170
-                if self.conf.fssnap_abort_on_errors in ('snapshot-failure', 'any'):
d2a170
-                    raise Errors.YumRPMTransError(msg="Aborting transaction", errors=msg)
d2a170
-                else:
d2a170
-                    self.verbose_logger.critical(msg)
d2a170
-            else:
d2a170
-                tags = {'*': ['reason=automatic']} # FIXME: pre. tags
d2a170
-                snaps = self.fssnap.snapshot(self.conf.fssnap_percentage, tags=tags)
d2a170
-                if not snaps:
d2a170
-                    msg = _("Failed to create snapshot")
d2a170
-                    if self.conf.fssnap_abort_on_errors in ('snapshot-failure', 'any'):
d2a170
-                        raise Errors.YumRPMTransError(msg="Aborting transaction", errors=msg)
d2a170
-                    else:
d2a170
-                        self.verbose_logger.critical(msg)
d2a170
-                for (odev, ndev) in snaps:
d2a170
-                    self.verbose_logger.info(_("Created snapshot from %s, results is: %s") % (odev, ndev))
d2a170
+            create_snapshot()
d2a170
 
d2a170
         self.plugins.run('pretrans')
d2a170
 
d2a170
@@ -1912,16 +1944,7 @@ much more problems).
d2a170
         if (self.fssnap.available and
d2a170
             (not self.ts.isTsFlagSet(rpm.RPMTRANS_FLAG_TEST) and
d2a170
             self.conf.fssnap_automatic_post)):
d2a170
-            if not self.fssnap.has_space(self.conf.fssnap_percentage):
d2a170
-                msg = _("Not enough space on logical volumes to create post trans FS snapshot.")
d2a170
-                self.verbose_logger.critical(msg)
d2a170
-            else:
d2a170
-                tags = {'*': ['reason=automatic']} # FIXME: post tags
d2a170
-                snaps = self.fssnap.snapshot(self.conf.fssnap_percentage, tags=tags)
d2a170
-                if not snaps:
d2a170
-                    self.verbose_logger.critical(_("Failed to create snapshot"))
d2a170
-                for (odev, ndev) in snaps:
d2a170
-                    self.verbose_logger.info(_("Created snapshot from %s, results is: %s") % (odev, ndev))
d2a170
+            create_snapshot(post=True)
d2a170
         return resultobject
d2a170
 
d2a170
     def verifyTransaction(self, resultobject=None, txmbr_cb=None):