def test__logs_messages(self):
events = []
namespace = factory.make_name("namespace")
legacy_logger = LegacyLogger(namespace, self, events.append)
message = factory.make_name("message")
keywords = {
factory.make_name("key"): factory.make_name("value")
for _ in range(3)
}
legacy_logger.msg(message, **keywords)
expected = {
'log_format': Equals('{_message_0}'),
'log_level': Equals(logger.LogLevel.info),
'log_logger': Is(legacy_logger),
'log_namespace': Equals(namespace),
'log_source': Is(self),
'log_time': IsInstance(float),
'_message_0': Equals(message),
}
expected.update(
{key: Equals(value)
for key, value in keywords.items()})
self.assertThat(events, HasLength(1))
self.assertThat(events[0], MatchesDict(expected))
self.assertThat(
logger.formatEventAsClassicLogText(events[0], formatTimeStatic),
Equals("<when> [%s#info] %s\n" % (namespace, message)))
def test__logs_multiple_messages(self):
events = []
legacy_logger = LegacyLogger(observer=events.append)
messages = [
factory.make_name("message"),
factory.make_name("message"),
factory.make_name("message"),
]
legacy_logger.msg(*messages)
expected = {
"_message_0": messages[0],
"_message_1": messages[1],
"_message_2": messages[2],
"log_format": "{_message_0} {_message_1} {_message_2}",
}
self.assertThat(events, HasLength(1))
self.assertThat(events[0], ContainsDictByEquality(expected))
self.assertThat(
logger.formatEventAsClassicLogText(events[0], formatTimeStatic),
Equals("<when> [%s#info] %s\n" % (__name__, " ".join(messages))))