Python-logging模块

1、日志级别：

　　

　　日志级别指的是产生日志的事件的严重程度；

　　设置一个级别后，严重程度低于设置值的日志消息将被忽略 。

2、格式字符串 

　　

　　注意：funcName，threadName，processName 都是小驼峰命名

2、默认级别：　

import logging

FORMAT = '%(asctime)-15s\t Thread info: %(thread)d %(threadName)s %(message)s'
logging.basicConfig(format=FORMAT)

logging.info('I am {}'.format(20))
logging.warning('I am {}'.format(20))

 

2018-10-30 13:57:32,714     Thread info: 9568 MainThread I am 20

　　默认级别是warning，所以低于warning的就无法显示。

3、构建消息：（格式定义使用的是C 风格的）

　　级别修改为  INFO 级别，两条都显示了

import logging

FORMAT = '%(asctime)-15s\t Thread info: %(thread)d %(threadName)s %(message)s'
logging.basicConfig(format=FORMAT, level=logging.INFO)

logging.info('I am {}'.format(20))
logging.warning('I am {}'.format(30))

2018-10-30 14:00:24,329     Thread info: 8724 MainThread I am 20
2018-10-30 14:00:24,329     Thread info: 8724 MainThread I am 30

 

　　使用字典，自定义一些显示信息（但是一般不会这么用，要不就直接定义到 FROMAT中）

import logging

FORMAT = '%(asctime)-15s\t Thread info: %(thread)d %(threadName)s %(message)s %(school)s'
logging.basicConfig(format=FORMAT, level=logging.WARNING)

d = {'school':'magedu'}

logging.info('I am {}'.format(20), extra=d)
logging.warning('I am {}'.format(30), extra=d)

2018-10-30 14:04:28,030     Thread info: 10184 MainThread I am 30 magedu

 

4、修改日期格式：注意定义格式的位置 basicConfig

import logging

FORMAT = '%(asctime)-15s\t Thread info: %(thread)d %(threadName)s %(message)s '
logging.basicConfig(format=FORMAT, level=logging.INFO, datefmt="%Y:%m:%d -- %H:%M:%S")

logging.info('I am {}'.format(20))
logging.warning('I am {}'.format(30))

 

2018:10:30 -- 14:15:49     Thread info: 9864 MainThread I am 20 
2018:10:30 -- 14:15:49     Thread info: 9864 MainThread I am 30 

 

5、输出到文件：　 注意定义格式的位置 basicConfig

import logging

FORMAT = '%(asctime)-15s\t Thread info: %(thread)d %(threadName)s %(message)s ' - 是向左靠齐，如果数字小于长度，不会截断
logging.basicConfig(format=FORMAT, level=logging.INFO,
                    datefmt="%Y:%m:%d -- %H:%M:%S",
                    filename='f:/test.log'
                    )

logging.info('I am {}'.format(20))
logging.warning('I am {}'.format(30))

 

 

 

 

　　注：默认是追加模式，也就是追加模式，只为了输出到文件。

　　　　

 6、Logger类：

 　　logging模块加载的时候，会创建一个root logger， 根Logger对象的默认级别是WARNING。

　　调用 logging.basicConfig 来调整级别，就是对这个根 Logger的级别进行修改

　　

 7、构造

　　logging.getLogger( [name= None) ]

　　使用工厂方法 返回 一个Logger实例

　　指定name，返回一个名称为 name 的 Logger实例，如果再次使用相同的名字，是实例化一个对象。

　　未指定 name， 返回的是 root Logger实例

import logging

FORMAT = '%(name)s %(asctime)s %(thread)d %(threadName)s %(message)s '
logging.basicConfig(format=FORMAT, level=logging.INFO)

logging.info('I am {}'.format(20))

log = logging.getLogger()
print(log.name)
print(logging.root.name)

log1 = logging.getLogger('s')
print(log1.name)

log2 = logging.getLogger('s')
print(log2.name)

log3 = logging.getLogger('s1')
print(log3.name)

 

root
root
s
s
s1
root 2018-10-30 14:44:44,900 10024 MainThread I am 20 

 

　　总结：

　　　　利用工程函数logging.getLogger(), 如果没有指定名字，就返回root ，如果执行，相当于创建一个新的logger对象，name是自己定义的。

　　　　如果在使用 工厂方法，name是之前的，也就是调用之前的logging对象，并没有创建新的 对象

 

8、层次构造：

　　Logger是层次结构的，使用 点号分割，如 a  --  a.b ---a.b.c  , a 是a.b的父，a.b是a的子。

import logging

FORMAT = '%(name)s %(asctime)s %(thread)d %(threadName)s %(message)s '
logging.basicConfig(format=FORMAT, level=logging.INFO)

logging.info('I am {}'.format(20))

log = logging.getLogger()
print(log.name)
print(logging.root.name)

log1 = logging.getLogger('s')
print(log1.name)

log2 = logging.getLogger('s.s1')
print(log2.name)

print(log2.parent)
print(log2.parent.name)
print(log2.parent.parent)
print(log2.parent.parent.name)

 

root 2018-10-30 14:52:48,827 5520 MainThread I am 20 
root
root
s
s.s1
<Logger s (INFO)>
s
<RootLogger root (INFO)>
root

　　测试: 级别测试

import logging

FORMAT = '%(asctime)s %(thread)d %(threadName)s %(message)s '
logging.basicConfig(format=FORMAT, level=logging.INFO)

logger = logging.getLogger(__name__) # 创建一个新的logger，未定义级别
print(logger.name, type(logger))
print(logger.level) # 新建的 logger 是未定义级别的，所以自己的级别是 0
print(logger.getEffectiveLevel()) # 有效级别 也就是从父类流过来的， 20（这里并不是继承）

logger.debug('==== hello ====') # 不打印，级别小于INFO
logger.info('==== hello ====') #输出
logger.warning('==== hello ====') # 输出


logger.setLevel(10)# 这里是0，就从父logger来，不是0 就用自己的跟下面的比较
print(logger.level) # 30
logger.debug('==== h1 ====') # 输出，大于10（debug)
logger.info('==== h2 ====') #
logger.warning('==== h3 ====') # 输出

D:\python3.7\python.exe E:/code_pycharm/tt.py
2018-10-30 15:09:37,638 8468 MainThread ==== hello ==== 
__main__ <class 'logging.Logger'>
2018-10-30 15:09:37,638 8468 MainThread ==== hello ==== 
0
2018-10-30 15:09:37,638 8468 MainThread ==== h1 ==== 
2018-10-30 15:09:37,638 8468 MainThread ==== h2 ==== 
20
10
2018-10-30 15:09:37,638 8468 MainThread ==== h3 ==== 

Process finished with exit code 0

 

 

import logging

FORMAT = '%(asctime)s %(thread)d %(threadName)s %(message)s '
logging.basicConfig(format=FORMAT, level=logging.INFO)

logger = logging.getLogger(__name__) # 创建一个新的logger，未定义级别
print(logger.name, type(logger))
print(logger.level) # 新建的 logger 是未定义级别的，所以自己的级别是 0
print(logger.getEffectiveLevel()) # 有效级别 也就是从父类流过来的， 20（这里并不是继承）

logger.debug('==== hello ====') # 不打印，级别小于INFO
logger.info('==== hello ====') #输出
logger.warning('==== hello ====') # 输出


logger.setLevel(18)# 这里是0，就从父logger来，不是0 就用自己的跟下面的比较
print(logger.level) # 30
logger.debug('==== h1 ====') # 输出，大于10（debug)
logger.info('==== h2 ====') #
logger.warning('==== h3 ====') # 输出
print(logger.getEffectiveLevel(), '===')

print(logging.getLogger().getEffectiveLevel())

D:\python3.7\python.exe E:/code_pycharm/tt.py
2018-10-30 15:15:16,786 6624 MainThread ==== hello ==== 
__main__ <class 'logging.Logger'>
0
2018-10-30 15:15:16,786 6624 MainThread ==== hello ==== 
20
18
2018-10-30 15:15:16,787 6624 MainThread ==== h2 ==== 
18 ===
20
2018-10-30 15:15:16,787 6624 MainThread ==== h3 ==== 

Process finished with exit code 0

　　每一个 logger创建后 ，都有一个等效的level

　　logger对象可以在创建后动态的修改自己的 level

9、Hander：

　　Hander 控制 日志信息的输出目的地，可以是控制台，文件

　　可以单独设置level

　　可以单独设置格式

　　可以设置过滤器

 

　　Handler 类 继承

　　　　Handler：

　　　　　　StreamHandler： # 不指定输出方式，默认是 sys.stderr

　　　　　　FileHandler： #文件

　　　　　　_SterrHandlerr # 标准输出

　　　　NullHandler # 什么都不做

　　日志输出其实是Handler 做的，也就是真正干活的是Handler。

　　在 logging.basicConfig 中，如下：

if handlers is None:
        filename = kwargs.pop('filename', None)
        mode = kwargs.pop('filemode','a')
        if filename:
            h = FileHandler(filename, mode)
        else:
            stream = kwargs.pop('stream', None)
            h = StreamHandler(stream)
        handlers = [h]

 

　　注：

　　　　如果 设置文件名，则为根 logger 加一个输出到文件的Handler；如果没有设置文件名，则为 根logger 加一个StreamHadler，默认输出到sys.stderr

　　　　也就是说， 根logger 一定会至少有一个handler的

　　　　新创建的logger 是没有 handler的，但是 根handler 是有一个默认的 streamhandler，所以新建的logger就用根logger的。

　　测试：Handler的默认level

import logging

FORMAT = '%(asctime)s %(name)s %(message)s'
logging.basicConfig(format=FORMAT, level=logging.INFO)

logger = logging.getLogger(__name__)
print(logger.name, type(logger))

logger.info('line ---- 1')

handler = logging.FileHandler('f:\\ll.log', 'a') #  filename, mode='a', encoding=None, delay=False
logger.addHandler(handler)
print(logger.handlers) # [<FileHandler f:\ll.log (NOTSET)>]

logger.info('line --- 2')

 　　　　结果可以看出：　　

　　　　　　　　默认handler是没有设置的 NOTSET

　　　　　　　　定义的FileHanfler 是最简单的 就一个message 输出。

　　　　　　　　logger 这个对象，一个是利用的root的streamhandler 打印到stderr， 一个是自定义的filehandler ，输出到文件

 　　测试：handler的level， 为了方便看文件，使用w 模式

import logging

FORMAT = '%(asctime)s %(name)s %(message)s'
logging.basicConfig(format=FORMAT, level=logging.INFO)

logger = logging.getLogger(__name__)
print(logger.name, type(logger))

logger.info('line ---- 1')

handler = logging.FileHandler('f:\\ll.log', 'w') #  filename, mode='a', encoding=None, delay=False
logger.addHandler(handler)
handler.setLevel(50)

logger.info('line --- 2')
print(logger.handlers) # [<FileHandler f:\ll.log (NOTSET)>]

 

 

 　　　　　结果可以看到：

　　　　　　　　filehandler的level设置为50 ，不影响stderr 输出，只影响了文件输出。

　　　　　　　　因为logger的输出级别是info，小于 50，所以输出不到文件

 10、继承关系 及信息传递：

　　

　　propagate的使用： 　　　　

　　　　　　

　　　　　　

　　官方日志流转图：

　　　　

 

 　　实例：

import logging

FORMAT = '%(asctime)s %(name)s %(message)s'
logging.basicConfig(format=FORMAT, level=logging.INFO)

root = logging.getLogger()
root.setLevel(logging.ERROR)
print('root', root.handlers)

h0 = logging.StreamHandler()
h0.setLevel(logging.WARNING)

root.addHandler(h0)
print('root', root.handlers)

for h in root.handlers:
    print('root handler = {}, formatter =  {}'.format(h, h.formatter))

'''
root [<StreamHandler <stderr> (NOTSET)>]
root [<StreamHandler <stderr> (NOTSET)>, <StreamHandler <stderr> (WARNING)>]
root handler = <StreamHandler <stderr> (NOTSET)>, formatter =  <logging.Formatter object at 0x000000000224C908>
root handler = <StreamHandler <stderr> (WARNING)>, formatter =  None
'''
################################################################################
print('==================================================')

log1 = logging.getLogger('s')
log1.setLevel(logging.ERROR)
h1 = logging.FileHandler('f:/tets.log')
h1.setLevel(logging.WARNING)
log1.addHandler(h1)
print('h1', log1.handlers)

print('==================================================')

log2 = logging.getLogger('s.s1')
log2.setLevel(logging.CRITICAL)
h2 = logging.FileHandler('f:/tets.log')
h2.setLevel(logging.WARNING)
log2.addHandler(h2)
print('h2', log2.handlers)

print('==================================================')

log3 = logging.getLogger('s.s1.s2')
log3.setLevel(logging.INFO)
print(log3.getEffectiveLevel())
h3 = logging.FileHandler('f:/tets.log')
h3.setLevel(logging.WARNING)
log3.addHandler(h3)
print('h3', log3.handlers)

　

D:\python3.7\python.exe E:/code_pycharm/tt2.py
root [<StreamHandler <stderr> (NOTSET)>]
root [<StreamHandler <stderr> (NOTSET)>, <StreamHandler <stderr> (WARNING)>]
root handler = <StreamHandler <stderr> (NOTSET)>, formatter =  <logging.Formatter object at 0x0000000001DD73C8>
root handler = <StreamHandler <stderr> (WARNING)>, formatter =  None
==================================================
h1 [<FileHandler f:\tets.log (WARNING)>]
==================================================
h2 [<FileHandler f:\tets.log (WARNING)>]
==================================================
20
h3 [<FileHandler f:\tets.log (WARNING)>]

Process finished with exit code 0

 

 

 11、Formatter

　　logging的Formatter类，它允许指定某个格式的字符串，如果提供None，那么 %(message)s作为默认值

　　修改上面的实例：

import logging

FORMAT = '%(asctime)s %(name)s %(message)s'
logging.basicConfig(format=FORMAT, level=logging.INFO)

root = logging.getLogger()
root.setLevel(logging.ERROR)
print('root', root.handlers)

h0 = logging.StreamHandler()
h0.setLevel(logging.WARNING)

root.addHandler(h0)
print('root', root.handlers)

for h in root.handlers:
    print('root handler = {}, formatter =  {}'.format(h, h.formatter))

'''
root [<StreamHandler <stderr> (NOTSET)>]
root [<StreamHandler <stderr> (NOTSET)>, <StreamHandler <stderr> (WARNING)>]
root handler = <StreamHandler <stderr> (NOTSET)>, formatter =  <logging.Formatter object at 0x000000000224C908>
root handler = <StreamHandler <stderr> (WARNING)>, formatter =  None
'''
################################################################################
print('==================================================')

log1 = logging.getLogger('s')
log1.setLevel(logging.ERROR)
h1 = logging.FileHandler('f:/tets.log')
h1.setLevel(logging.WARNING)
print('h1 handler = {}, formatter =  {}'.format(h1, h1.formatter))
log1.addHandler(h1)
print('h1', log1.handlers)

print('==================================================')

log2 = logging.getLogger('s.s1')
log2.setLevel(logging.DEBUG)
h2 = logging.FileHandler('f:/tets.log')
h2.setLevel(logging.WARNING)

print('log2 formatter', h2.formatter)
f2 = logging.Formatter('log2 %(name)s %(asctime)s %(message)s')
h2.setFormatter(f2)
log2.addHandler(h2)
log2.info('log2----')
print('log2 formatter', h2.formatter)
print('h2', log2.handlers)

 

D:\python3.7\python.exe E:/code_pycharm/tt2.py
root [<StreamHandler <stderr> (NOTSET)>]
root [<StreamHandler <stderr> (NOTSET)>, <StreamHandler <stderr> (WARNING)>]
root handler = <StreamHandler <stderr> (NOTSET)>, formatter =  <logging.Formatter object at 0x0000000001D773C8>
root handler = <StreamHandler <stderr> (WARNING)>, formatter =  None
==================================================
h1 handler = <FileHandler f:\tets.log (WARNING)>, formatter =  None
h1 [<FileHandler f:\tets.log (WARNING)>]
==================================================
log2 formatter None
log2 formatter <logging.Formatter object at 0x0000000002A09128>
h2 [<FileHandler f:\tets.log (WARNING)>]
2018-10-30 17:14:11,489 s.s1 log2----

Process finished with exit code 0

 

　　　　如何设置格式：

log2 = logging.getLogger('s.s1')
log2.setLevel(logging.DEBUG)
h2 = logging.FileHandler('f:/tets.log')
h2.setLevel(logging.WARNING)

print('log2 formatter', h2.formatter)
f2 = logging.Formatter('log2 %(name)s %(asctime)s %(message)s')
h2.setFormatter(f2)
log2.addHandler(h2)
log2.info('log2----')
print('log2 formatter', h2.formatter)
print('h2', log2.handlers)

 

　　　　　

12、Filter 过滤

　　可以为handler增加过滤器，所以这种过滤器只影响某一个handler， 不会影响整个处理流程，但是，如果过滤器增加到logger上，就会影响流程。

　　

import logging

FORMAT = '%(asctime)s %(name)s %(message)s'
logging.basicConfig(format=FORMAT, level=logging.INFO)

log1 = logging.getLogger('s')
log1.setLevel(30)

# h1 = logging.FileHandler('f:/0.log', 'w')
h1 = logging.StreamHandler()
h1.setLevel(logging.INFO)

fmt1 = logging.Formatter('------log1 - h1 %(message)s')
h1.setFormatter(fmt1)
log1.addHandler(h1)

############# log 2 #########
log2 = logging.getLogger('s.s1')
print(log2.getEffectiveLevel())

h2 = logging.StreamHandler()
h2.setLevel(logging.INFO)

fmt2 = logging.Formatter('log2 -h2 %(message)s')
h2.setFormatter(fmt2)

f2 = logging.Filter('p')
h2.addFilter(f2)

log2.addHandler(h2)

log2.warning('-----log2 warning')

------log1 - h1 -----log2 warning
2018-10-30 17:53:22,143 s.s1 -----log2 warning
30