python实例：使用装饰器实现打印函数的执行时间

# -*- coding: utf-8 -*-
import time
import functools


def log(text=''):
    def metric(fn):
        @functools.wraps(fn)
        def wrapper(*args, **kwargs):
            t_begin = time.time()
            print('%s start at %0.4f' % (fn.__name__, t_begin))
            res = fn(*args, **kwargs)
            t_end = time.time()
            print('%s end at %0.4f' % (fn.__name__, t_end))
            print('%s%s executed in %s ms' % (text, fn.__name__, t_end - t_begin))
            return res
        return wrapper
    return metric


@log()
def fast(x, y):
    time.sleep(0.0012)
    return x + y


@log()
def slow(x, y, z):
    time.sleep(0.1234)
    return x * y * z


f = fast(11, 22)
s = slow(11, 22, 33)
if f != 33:
    print('测试失败!')
elif s != 7986:
    print('测试失败!')

个人这样理解python装饰器，当一个函数加入了装饰器以后，调用该函数时，会把当前的函数名指向装饰器函数。相当于调用本函数就是执行一遍装饰器函数的内容。在本例子中，先执行log-->调用metric-->调用wrapper-->调用fn，fn即我们使用的函数（即fast和slow），最终调用的层次为wrapper层。所以此时打印fn.__name的时候名称是wrapper。为避免引起歧义，需执行这条语句@functools.wraps(fn)