test_logger.py 28 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235236237238239240241242243244245246247248249250251252253254255256257258259260261262263264265266267268269270271272273274275276277278279280281282283284285286287288289290291292293294295296297298299300301302303304305306307308309310311312313314315316317318319320321322323324325326327328329330331332333334335336337338339340341342343344345346347348349350351352353354355356357358359360361362363364365366367368369370371372373374375376377378379380381382383384385386387388389390391392393394395396397398399400401402403404405406407408409410411412413414415416417418419420421422423424425426427428429430431432433434435436437438439440441442443444445446447448449450451452453454455456457458459460461462463464465466467468469470471472473474475476477478479480481482483484485486487488489490491492493494495496497498499500501502503504505506507508509510511512513514515516517518519520521522523524525526527528529530531532533534535536537538539540541542543544545546547548549550551552553554555556557558559560561562563564565566567568569570571572573574575576577578579580581582583584585586587588589590591592593594595596597598599600601602603604605606607608609610611612613614615616617618619620621622623624625626627628629630631632633634635636637638639640641642643644645646647648649650651652653654655656657658659660661662663664665666667668669670671672673674675676677
  1. import logging
  2. import sys
  3. import pytest
  4. from flexmock import flexmock
  5. from borgmatic import logger as module
  6. @pytest.mark.parametrize('bool_val', (True, 'yes', 'on', '1', 'true', 'True', 1))
  7. def test_to_bool_parses_true_values(bool_val):
  8. assert module.to_bool(bool_val)
  9. @pytest.mark.parametrize('bool_val', (False, 'no', 'off', '0', 'false', 'False', 0))
  10. def test_to_bool_parses_false_values(bool_val):
  11. assert not module.to_bool(bool_val)
  12. def test_to_bool_passes_none_through():
  13. assert module.to_bool(None) is None
  14. def test_interactive_console_false_when_not_isatty(capsys):
  15. with capsys.disabled():
  16. flexmock(module.sys.stderr).should_receive('isatty').and_return(False)
  17. assert module.interactive_console() is False
  18. def test_interactive_console_false_when_TERM_is_dumb(capsys):
  19. with capsys.disabled():
  20. flexmock(module.sys.stderr).should_receive('isatty').and_return(True)
  21. flexmock(module.os.environ).should_receive('get').with_args('TERM').and_return('dumb')
  22. assert module.interactive_console() is False
  23. def test_interactive_console_true_when_isatty_and_TERM_is_not_dumb(capsys):
  24. with capsys.disabled():
  25. flexmock(module.sys.stderr).should_receive('isatty').and_return(True)
  26. flexmock(module.os.environ).should_receive('get').with_args('TERM').and_return('smart')
  27. assert module.interactive_console() is True
  28. def test_should_do_markup_respects_no_color_value():
  29. flexmock(module.os.environ).should_receive('get').and_return(None)
  30. flexmock(module).should_receive('interactive_console').never()
  31. assert module.should_do_markup(no_color=True, configs={}) is False
  32. def test_should_do_markup_respects_config_value():
  33. flexmock(module.os.environ).should_receive('get').and_return(None)
  34. flexmock(module).should_receive('interactive_console').never()
  35. assert module.should_do_markup(no_color=False, configs={'foo.yaml': {'color': False}}) is False
  36. flexmock(module).should_receive('interactive_console').and_return(True).once()
  37. assert module.should_do_markup(no_color=False, configs={'foo.yaml': {'color': True}}) is True
  38. def test_should_do_markup_prefers_any_false_config_value():
  39. flexmock(module.os.environ).should_receive('get').and_return(None)
  40. flexmock(module).should_receive('interactive_console').never()
  41. assert (
  42. module.should_do_markup(
  43. no_color=False,
  44. configs={
  45. 'foo.yaml': {'color': True},
  46. 'bar.yaml': {'color': False},
  47. },
  48. )
  49. is False
  50. )
  51. def test_should_do_markup_respects_PY_COLORS_environment_variable():
  52. flexmock(module.os.environ).should_receive('get').with_args('PY_COLORS', None).and_return(
  53. 'True'
  54. )
  55. flexmock(module.os.environ).should_receive('get').with_args('NO_COLOR', None).and_return(None)
  56. flexmock(module).should_receive('to_bool').and_return(True)
  57. assert module.should_do_markup(no_color=False, configs={}) is True
  58. def test_should_do_markup_prefers_no_color_value_to_config_value():
  59. flexmock(module.os.environ).should_receive('get').and_return(None)
  60. flexmock(module).should_receive('interactive_console').never()
  61. assert module.should_do_markup(no_color=True, configs={'foo.yaml': {'color': True}}) is False
  62. def test_should_do_markup_prefers_config_value_to_environment_variables():
  63. flexmock(module.os.environ).should_receive('get').and_return('True')
  64. flexmock(module).should_receive('to_bool').and_return(True)
  65. flexmock(module).should_receive('interactive_console').never()
  66. assert module.should_do_markup(no_color=False, configs={'foo.yaml': {'color': False}}) is False
  67. def test_should_do_markup_prefers_no_color_value_to_environment_variables():
  68. flexmock(module.os.environ).should_receive('get').and_return('True')
  69. flexmock(module).should_receive('to_bool').and_return(True)
  70. flexmock(module).should_receive('interactive_console').never()
  71. assert module.should_do_markup(no_color=True, configs={}) is False
  72. def test_should_do_markup_respects_interactive_console_value():
  73. flexmock(module.os.environ).should_receive('get').and_return(None)
  74. flexmock(module).should_receive('interactive_console').and_return(True)
  75. assert module.should_do_markup(no_color=False, configs={}) is True
  76. def test_should_do_markup_prefers_PY_COLORS_to_interactive_console_value():
  77. flexmock(module.os.environ).should_receive('get').with_args('PY_COLORS', None).and_return(
  78. 'True'
  79. )
  80. flexmock(module.os.environ).should_receive('get').with_args('NO_COLOR', None).and_return(None)
  81. flexmock(module).should_receive('to_bool').and_return(True)
  82. flexmock(module).should_receive('interactive_console').never()
  83. assert module.should_do_markup(no_color=False, configs={}) is True
  84. def test_should_do_markup_prefers_NO_COLOR_to_interactive_console_value():
  85. flexmock(module.os.environ).should_receive('get').with_args('PY_COLORS', None).and_return(None)
  86. flexmock(module.os.environ).should_receive('get').with_args('NO_COLOR', None).and_return('True')
  87. flexmock(module).should_receive('interactive_console').never()
  88. assert module.should_do_markup(no_color=False, configs={}) is False
  89. def test_should_do_markup_respects_NO_COLOR_environment_variable():
  90. flexmock(module.os.environ).should_receive('get').with_args('NO_COLOR', None).and_return('True')
  91. flexmock(module.os.environ).should_receive('get').with_args('PY_COLORS', None).and_return(None)
  92. flexmock(module).should_receive('interactive_console').never()
  93. assert module.should_do_markup(no_color=False, configs={}) is False
  94. def test_should_do_markup_ignores_empty_NO_COLOR_environment_variable():
  95. flexmock(module.os.environ).should_receive('get').with_args('NO_COLOR', None).and_return('')
  96. flexmock(module.os.environ).should_receive('get').with_args('PY_COLORS', None).and_return(None)
  97. flexmock(module).should_receive('interactive_console').and_return(True)
  98. assert module.should_do_markup(no_color=False, configs={}) is True
  99. def test_should_do_markup_prefers_NO_COLOR_to_PY_COLORS():
  100. flexmock(module.os.environ).should_receive('get').with_args('PY_COLORS', None).and_return(
  101. 'True'
  102. )
  103. flexmock(module.os.environ).should_receive('get').with_args('NO_COLOR', None).and_return(
  104. 'SomeValue'
  105. )
  106. flexmock(module).should_receive('interactive_console').never()
  107. assert module.should_do_markup(no_color=False, configs={}) is False
  108. def test_multi_stream_handler_logs_to_handler_for_log_level():
  109. error_handler = flexmock()
  110. error_handler.should_receive('emit').once()
  111. info_handler = flexmock()
  112. multi_handler = module.Multi_stream_handler(
  113. {module.logging.ERROR: error_handler, module.logging.INFO: info_handler}
  114. )
  115. multi_handler.emit(flexmock(levelno=module.logging.ERROR))
  116. def test_console_color_formatter_format_includes_log_message():
  117. flexmock(module).should_receive('add_custom_log_levels')
  118. flexmock(module.logging).ANSWER = module.ANSWER
  119. plain_message = 'uh oh'
  120. flexmock(module.logging.Formatter).should_receive('format').and_return(plain_message)
  121. record = flexmock(levelno=logging.CRITICAL)
  122. colored_message = module.Console_color_formatter().format(record)
  123. assert colored_message != plain_message
  124. assert plain_message in colored_message
  125. def test_color_text_does_not_raise():
  126. flexmock(module).should_receive('ansi_escape_code').and_return('blah')
  127. module.color_text(module.Color.RED, 'hi')
  128. def test_color_text_without_color_does_not_raise():
  129. flexmock(module).should_receive('ansi_escape_code').and_return('blah')
  130. module.color_text(None, 'hi')
  131. def test_add_logging_level_adds_level_name_and_sets_global_attributes_and_methods():
  132. logger = flexmock()
  133. flexmock(module.logging).should_receive('getLoggerClass').and_return(logger)
  134. flexmock(module.logging).should_receive('addLevelName').with_args(99, 'PLAID')
  135. builtins = flexmock(sys.modules['builtins'])
  136. builtins.should_call('setattr')
  137. builtins.should_receive('setattr').with_args(module.logging, 'PLAID', 99).once()
  138. builtins.should_receive('setattr').with_args(logger, 'plaid', object).once()
  139. builtins.should_receive('setattr').with_args(logging, 'plaid', object).once()
  140. module.add_logging_level('PLAID', 99)
  141. def test_add_logging_level_skips_global_setting_if_already_set():
  142. logger = flexmock()
  143. flexmock(module.logging).should_receive('getLoggerClass').and_return(logger)
  144. flexmock(module.logging).PLAID = 99
  145. flexmock(logger).plaid = flexmock()
  146. flexmock(logging).plaid = flexmock()
  147. flexmock(module.logging).should_receive('addLevelName').never()
  148. builtins = flexmock(sys.modules['builtins'])
  149. builtins.should_call('setattr')
  150. builtins.should_receive('setattr').with_args(module.logging, 'PLAID', 99).never()
  151. builtins.should_receive('setattr').with_args(logger, 'plaid', object).never()
  152. builtins.should_receive('setattr').with_args(logging, 'plaid', object).never()
  153. module.add_logging_level('PLAID', 99)
  154. def test_get_log_prefix_gets_prefix_from_first_handler_formatter_with_prefix():
  155. flexmock(module.logging).should_receive('getLogger').and_return(
  156. flexmock(
  157. handlers=[
  158. flexmock(formatter=flexmock()),
  159. flexmock(formatter=flexmock(prefix='myprefix')),
  160. ],
  161. removeHandler=lambda handler: None,
  162. )
  163. )
  164. assert module.get_log_prefix() == 'myprefix'
  165. def test_get_log_prefix_with_no_handlers_does_not_raise():
  166. flexmock(module.logging).should_receive('getLogger').and_return(
  167. flexmock(
  168. handlers=[],
  169. removeHandler=lambda handler: None,
  170. )
  171. )
  172. assert module.get_log_prefix() is None
  173. def test_get_log_prefix_with_no_formatters_does_not_raise():
  174. flexmock(module.logging).should_receive('getLogger').and_return(
  175. flexmock(
  176. handlers=[
  177. flexmock(formatter=None),
  178. flexmock(formatter=None),
  179. ],
  180. removeHandler=lambda handler: None,
  181. )
  182. )
  183. assert module.get_log_prefix() is None
  184. def test_get_log_prefix_with_no_prefix_does_not_raise():
  185. flexmock(module.logging).should_receive('getLogger').and_return(
  186. flexmock(
  187. handlers=[
  188. flexmock(
  189. formatter=flexmock(),
  190. ),
  191. ],
  192. removeHandler=lambda handler: None,
  193. )
  194. )
  195. assert module.get_log_prefix() is None
  196. def test_set_log_prefix_updates_all_handler_formatters():
  197. formatters = (
  198. flexmock(prefix=None),
  199. flexmock(prefix=None),
  200. )
  201. flexmock(module.logging).should_receive('getLogger').and_return(
  202. flexmock(
  203. handlers=[
  204. flexmock(
  205. formatter=formatters[0],
  206. ),
  207. flexmock(
  208. formatter=formatters[1],
  209. ),
  210. ],
  211. removeHandler=lambda handler: None,
  212. )
  213. )
  214. module.set_log_prefix('myprefix')
  215. for formatter in formatters:
  216. assert formatter.prefix == 'myprefix'
  217. def test_set_log_prefix_skips_handlers_without_a_formatter():
  218. formatter = flexmock(prefix=None)
  219. flexmock(module.logging).should_receive('getLogger').and_return(
  220. flexmock(
  221. handlers=[
  222. flexmock(
  223. formatter=None,
  224. ),
  225. flexmock(
  226. formatter=formatter,
  227. ),
  228. ],
  229. removeHandler=lambda handler: None,
  230. )
  231. )
  232. module.set_log_prefix('myprefix')
  233. assert formatter.prefix == 'myprefix'
  234. def test_log_prefix_sets_prefix_and_then_restores_no_prefix_after():
  235. flexmock(module).should_receive('get_log_prefix').and_return(None)
  236. flexmock(module).should_receive('set_log_prefix').with_args('myprefix').once()
  237. flexmock(module).should_receive('set_log_prefix').with_args(None).once()
  238. with module.Log_prefix('myprefix'):
  239. pass
  240. def test_log_prefix_sets_prefix_and_then_restores_original_prefix_after():
  241. flexmock(module).should_receive('get_log_prefix').and_return('original')
  242. flexmock(module).should_receive('set_log_prefix').with_args('myprefix').once()
  243. flexmock(module).should_receive('set_log_prefix').with_args('original').once()
  244. with module.Log_prefix('myprefix'):
  245. pass
  246. def test_delayed_logging_handler_should_flush_without_targets_returns_false():
  247. handler = module.Delayed_logging_handler()
  248. assert handler.shouldFlush(flexmock()) is False
  249. def test_delayed_logging_handler_should_flush_with_targets_returns_true():
  250. handler = module.Delayed_logging_handler()
  251. handler.targets = [flexmock()]
  252. assert handler.shouldFlush(flexmock()) is True
  253. def test_delayed_logging_handler_flush_without_targets_does_not_raise():
  254. handler = module.Delayed_logging_handler()
  255. flexmock(handler).should_receive('acquire')
  256. flexmock(handler).should_receive('release')
  257. handler.flush()
  258. def test_delayed_logging_handler_flush_with_empty_buffer_does_not_raise():
  259. handler = module.Delayed_logging_handler()
  260. flexmock(handler).should_receive('acquire')
  261. flexmock(handler).should_receive('release')
  262. handler.targets = [flexmock()]
  263. handler.flush()
  264. def test_delayed_logging_handler_flush_forwards_each_record_to_each_target():
  265. handler = module.Delayed_logging_handler()
  266. flexmock(handler).should_receive('acquire')
  267. flexmock(handler).should_receive('release')
  268. handler.targets = [flexmock(), flexmock()]
  269. handler.buffer = [flexmock(), flexmock()]
  270. handler.targets[0].should_receive('handle').with_args(handler.buffer[0]).once()
  271. handler.targets[1].should_receive('handle').with_args(handler.buffer[0]).once()
  272. handler.targets[0].should_receive('handle').with_args(handler.buffer[1]).once()
  273. handler.targets[1].should_receive('handle').with_args(handler.buffer[1]).once()
  274. handler.flush()
  275. assert handler.buffer == []
  276. def test_flush_delayed_logging_without_handlers_does_not_raise():
  277. root_logger = flexmock(handlers=[])
  278. root_logger.should_receive('removeHandler')
  279. flexmock(module.logging).should_receive('getLogger').and_return(root_logger)
  280. module.flush_delayed_logging([flexmock()])
  281. def test_flush_delayed_logging_without_delayed_logging_handler_does_not_raise():
  282. root_logger = flexmock(handlers=[flexmock()])
  283. root_logger.should_receive('removeHandler')
  284. flexmock(module.logging).should_receive('getLogger').and_return(root_logger)
  285. module.flush_delayed_logging([flexmock()])
  286. def test_flush_delayed_logging_flushes_delayed_logging_handler():
  287. delayed_logging_handler = module.Delayed_logging_handler()
  288. root_logger = flexmock(handlers=[delayed_logging_handler])
  289. flexmock(module.logging).should_receive('getLogger').and_return(root_logger)
  290. flexmock(delayed_logging_handler).should_receive('flush').once()
  291. root_logger.should_receive('removeHandler')
  292. module.flush_delayed_logging([flexmock()])
  293. def test_configure_logging_with_syslog_log_level_probes_for_log_socket_on_linux():
  294. flexmock(module).should_receive('add_custom_log_levels')
  295. flexmock(module.logging).ANSWER = module.ANSWER
  296. fake_formatter = flexmock()
  297. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  298. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  299. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  300. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  301. flexmock(module).should_receive('interactive_console').and_return(False)
  302. flexmock(module).should_receive('flush_delayed_logging')
  303. flexmock(module.logging).should_receive('basicConfig').with_args(
  304. level=logging.DEBUG, handlers=list
  305. )
  306. flexmock(module.os.path).should_receive('exists').with_args('/dev/log').and_return(True)
  307. syslog_handler = logging.handlers.SysLogHandler()
  308. flexmock(module.logging.handlers).should_receive('SysLogHandler').with_args(
  309. address='/dev/log'
  310. ).and_return(syslog_handler).once()
  311. module.configure_logging(logging.INFO, syslog_log_level=logging.DEBUG)
  312. def test_configure_logging_with_syslog_log_level_probes_for_log_socket_on_macos():
  313. flexmock(module).should_receive('add_custom_log_levels')
  314. flexmock(module.logging).ANSWER = module.ANSWER
  315. fake_formatter = flexmock()
  316. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  317. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  318. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  319. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  320. flexmock(module).should_receive('interactive_console').and_return(False)
  321. flexmock(module).should_receive('flush_delayed_logging')
  322. flexmock(module.logging).should_receive('basicConfig').with_args(
  323. level=logging.DEBUG, handlers=list
  324. )
  325. flexmock(module.os.path).should_receive('exists').with_args('/dev/log').and_return(False)
  326. flexmock(module.os.path).should_receive('exists').with_args('/var/run/syslog').and_return(True)
  327. syslog_handler = logging.handlers.SysLogHandler()
  328. flexmock(module.logging.handlers).should_receive('SysLogHandler').with_args(
  329. address='/var/run/syslog'
  330. ).and_return(syslog_handler).once()
  331. module.configure_logging(logging.INFO, syslog_log_level=logging.DEBUG)
  332. def test_configure_logging_with_syslog_log_level_probes_for_log_socket_on_freebsd():
  333. flexmock(module).should_receive('add_custom_log_levels')
  334. flexmock(module.logging).ANSWER = module.ANSWER
  335. fake_formatter = flexmock()
  336. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  337. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  338. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  339. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  340. flexmock(module).should_receive('interactive_console').and_return(False)
  341. flexmock(module).should_receive('flush_delayed_logging')
  342. flexmock(module.logging).should_receive('basicConfig').with_args(
  343. level=logging.DEBUG, handlers=list
  344. )
  345. flexmock(module.os.path).should_receive('exists').with_args('/dev/log').and_return(False)
  346. flexmock(module.os.path).should_receive('exists').with_args('/var/run/syslog').and_return(False)
  347. flexmock(module.os.path).should_receive('exists').with_args('/var/run/log').and_return(True)
  348. syslog_handler = logging.handlers.SysLogHandler()
  349. flexmock(module.logging.handlers).should_receive('SysLogHandler').with_args(
  350. address='/var/run/log'
  351. ).and_return(syslog_handler).once()
  352. module.configure_logging(logging.INFO, syslog_log_level=logging.DEBUG)
  353. def test_configure_logging_without_syslog_log_level_skips_syslog():
  354. flexmock(module).should_receive('add_custom_log_levels')
  355. flexmock(module.logging).ANSWER = module.ANSWER
  356. fake_formatter = flexmock()
  357. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  358. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  359. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  360. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  361. flexmock(module).should_receive('flush_delayed_logging')
  362. flexmock(module.logging).should_receive('basicConfig').with_args(
  363. level=logging.INFO, handlers=list
  364. )
  365. flexmock(module.os.path).should_receive('exists').never()
  366. flexmock(module.logging.handlers).should_receive('SysLogHandler').never()
  367. module.configure_logging(console_log_level=logging.INFO)
  368. def test_configure_logging_skips_syslog_if_not_found():
  369. flexmock(module).should_receive('add_custom_log_levels')
  370. flexmock(module.logging).ANSWER = module.ANSWER
  371. fake_formatter = flexmock()
  372. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  373. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  374. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  375. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  376. flexmock(module).should_receive('flush_delayed_logging')
  377. flexmock(module.logging).should_receive('basicConfig').with_args(
  378. level=logging.INFO, handlers=list
  379. )
  380. flexmock(module.os.path).should_receive('exists').and_return(False)
  381. flexmock(module.logging.handlers).should_receive('SysLogHandler').never()
  382. module.configure_logging(console_log_level=logging.INFO, syslog_log_level=logging.DEBUG)
  383. def test_configure_logging_skips_log_file_if_log_file_logging_is_disabled():
  384. flexmock(module).should_receive('add_custom_log_levels')
  385. flexmock(module.logging).DISABLED = module.DISABLED
  386. fake_formatter = flexmock()
  387. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  388. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  389. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  390. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  391. flexmock(module).should_receive('flush_delayed_logging')
  392. flexmock(module.logging).should_receive('basicConfig').with_args(
  393. level=logging.INFO, handlers=list
  394. )
  395. flexmock(module.os.path).should_receive('exists').never()
  396. flexmock(module.logging.handlers).should_receive('SysLogHandler').never()
  397. flexmock(module.logging.handlers).should_receive('WatchedFileHandler').never()
  398. module.configure_logging(
  399. console_log_level=logging.INFO, log_file_log_level=logging.DISABLED, log_file='/tmp/logfile'
  400. )
  401. def test_configure_logging_to_log_file_instead_of_syslog():
  402. flexmock(module).should_receive('add_custom_log_levels')
  403. flexmock(module.logging).ANSWER = module.ANSWER
  404. fake_formatter = flexmock()
  405. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  406. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  407. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  408. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  409. flexmock(module).should_receive('flush_delayed_logging')
  410. flexmock(module.logging).should_receive('basicConfig').with_args(
  411. level=logging.DEBUG, handlers=list
  412. )
  413. flexmock(module.os.path).should_receive('exists').never()
  414. flexmock(module.logging.handlers).should_receive('SysLogHandler').never()
  415. file_handler = logging.handlers.WatchedFileHandler('/tmp/logfile')
  416. flexmock(module.logging.handlers).should_receive('WatchedFileHandler').with_args(
  417. '/tmp/logfile'
  418. ).and_return(file_handler).once()
  419. module.configure_logging(
  420. console_log_level=logging.INFO,
  421. syslog_log_level=logging.DISABLED,
  422. log_file_log_level=logging.DEBUG,
  423. log_file='/tmp/logfile',
  424. )
  425. def test_configure_logging_to_both_log_file_and_syslog():
  426. flexmock(module).should_receive('add_custom_log_levels')
  427. flexmock(module.logging).ANSWER = module.ANSWER
  428. fake_formatter = flexmock()
  429. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  430. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  431. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  432. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  433. flexmock(module).should_receive('flush_delayed_logging')
  434. flexmock(module.logging).should_receive('basicConfig').with_args(
  435. level=logging.DEBUG, handlers=list
  436. )
  437. flexmock(module.os.path).should_receive('exists').with_args('/dev/log').and_return(True)
  438. syslog_handler = logging.handlers.SysLogHandler()
  439. flexmock(module.logging.handlers).should_receive('SysLogHandler').with_args(
  440. address='/dev/log'
  441. ).and_return(syslog_handler).once()
  442. file_handler = logging.handlers.WatchedFileHandler('/tmp/logfile')
  443. flexmock(module.logging.handlers).should_receive('WatchedFileHandler').with_args(
  444. '/tmp/logfile'
  445. ).and_return(file_handler).once()
  446. module.configure_logging(
  447. console_log_level=logging.INFO,
  448. syslog_log_level=logging.DEBUG,
  449. log_file_log_level=logging.DEBUG,
  450. log_file='/tmp/logfile',
  451. )
  452. def test_configure_logging_to_log_file_formats_with_custom_log_format():
  453. flexmock(module).should_receive('add_custom_log_levels')
  454. flexmock(module.logging).ANSWER = module.ANSWER
  455. flexmock(module).should_receive('Log_prefix_formatter').with_args(
  456. '{message}', # noqa: FS003
  457. ).once()
  458. fake_formatter = flexmock()
  459. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  460. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  461. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  462. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  463. flexmock(module).should_receive('interactive_console').and_return(False)
  464. flexmock(module).should_receive('flush_delayed_logging')
  465. flexmock(module.logging).should_receive('basicConfig').with_args(
  466. level=logging.DEBUG, handlers=list
  467. )
  468. flexmock(module.os.path).should_receive('exists').with_args('/dev/log').and_return(True)
  469. flexmock(module.logging.handlers).should_receive('SysLogHandler').never()
  470. file_handler = logging.handlers.WatchedFileHandler('/tmp/logfile')
  471. flexmock(module.logging.handlers).should_receive('WatchedFileHandler').with_args(
  472. '/tmp/logfile'
  473. ).and_return(file_handler).once()
  474. module.configure_logging(
  475. console_log_level=logging.INFO,
  476. log_file_log_level=logging.DEBUG,
  477. log_file='/tmp/logfile',
  478. log_file_format='{message}', # noqa: FS003
  479. )
  480. def test_configure_logging_skips_log_file_if_argument_is_none():
  481. flexmock(module).should_receive('add_custom_log_levels')
  482. flexmock(module.logging).ANSWER = module.ANSWER
  483. fake_formatter = flexmock()
  484. flexmock(module).should_receive('Console_color_formatter').and_return(fake_formatter)
  485. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  486. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  487. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  488. flexmock(module).should_receive('flush_delayed_logging')
  489. flexmock(module.logging).should_receive('basicConfig').with_args(
  490. level=logging.INFO, handlers=list
  491. )
  492. flexmock(module.os.path).should_receive('exists').and_return(False)
  493. flexmock(module.logging.handlers).should_receive('WatchedFileHandler').never()
  494. module.configure_logging(console_log_level=logging.INFO, log_file=None)
  495. def test_configure_logging_uses_console_no_color_formatter_if_color_disabled():
  496. flexmock(module).should_receive('add_custom_log_levels')
  497. flexmock(module.logging).ANSWER = module.ANSWER
  498. fake_formatter = flexmock()
  499. flexmock(module).should_receive('Console_color_formatter').never()
  500. flexmock(module).should_receive('Log_prefix_formatter').and_return(fake_formatter)
  501. multi_stream_handler = flexmock(setLevel=lambda level: None, level=logging.INFO)
  502. multi_stream_handler.should_receive('setFormatter').with_args(fake_formatter).once()
  503. flexmock(module).should_receive('Multi_stream_handler').and_return(multi_stream_handler)
  504. flexmock(module).should_receive('flush_delayed_logging')
  505. flexmock(module.logging).should_receive('basicConfig').with_args(
  506. level=logging.INFO, handlers=list
  507. )
  508. flexmock(module.os.path).should_receive('exists').and_return(False)
  509. flexmock(module.logging.handlers).should_receive('WatchedFileHandler').never()
  510. module.configure_logging(console_log_level=logging.INFO, log_file=None, color_enabled=False)