Log chat history

Log all chat messages using the logging framework.

.docker/marvin/Dockerfile

@@ -1,7 +1,7 @@
 FROM python:3-alpine
 
 COPY . /app
-RUN mkdir -p /app
+RUN mkdir -p /app/logs
 WORKDIR /app
 
 RUN python3 -m pip install -r .requirements.txt

.gitignore

@@ -4,6 +4,7 @@ aggregate.error
 aggregate.ignore
 aggregate.log
 db.sqlite
+logs/
 # pycharm
 .idea/
 marvin_config.json

bot.py

@@ -16,6 +16,7 @@ def __init__(self):
         self.CONFIG = {}
         self.ACTIONS = []
         self.GENERAL_ACTIONS = []
+        self.MSG_LOG = logging.getLogger("message")
 
     def getConfig(self):
         """Return the current configuration"""

discord_bot.py

@@ -13,7 +13,6 @@
 
 from bot import Bot
 
-LOG = logging.getLogger("bot")
 
 class DiscordBot(discord.Client, Bot):
     """Bot implementing the discord protocol"""
@@ -46,7 +45,7 @@ async def checkMarvinActions(self, message):
 
     async def on_message(self, message):
         """Hook run on every message"""
-        LOG.debug("#%s <%s> %s", message.channel.name, message.author, message.content)
+        self.MSG_LOG.debug("#%s <%s> %s", message.channel.name, message.author, message.content)
         if message.author.name == self.user.name:
             # don't react to own messages
             return

irc_bot.py

@@ -93,13 +93,14 @@ def sendPrivMsg(self, message, channel):
         """Send and log a PRIV message"""
         if channel == self.CONFIG["channel"]:
             self.ircLogAppend(user=self.CONFIG["nick"].ljust(8), message=message)
+            self.MSG_LOG.debug("%s <%s>  %s", channel, self.CONFIG["nick"], message)
 
         msg = "PRIVMSG {CHANNEL} :{MSG}\r\n".format(CHANNEL=channel, MSG=message)
         self.sendMsg(msg)
 
     def sendMsg(self, msg):
         """Send and occasionally print the message sent"""
-        LOG.info("SEND: %s", msg.rstrip("\r\n"))
+        LOG.debug("SEND: %s", msg.rstrip("\r\n"))
         self.SOCKET.send(msg.encode())
 
     def decode_irc(self, raw, preferred_encs=None):
@@ -224,6 +225,10 @@ def checkIrcActions(self, words):
     def checkMarvinActions(self, words):
         """Check if Marvin should perform any actions"""
         if words[1] == 'PRIVMSG' and words[2] == self.CONFIG["channel"]:
+            self.MSG_LOG.debug("%s <%s>  %s",
+                               words[2],
+                               words[0].split(":")[1].split("!")[0],
+                               " ".join(words[3:]))
             self.ircLogAppend(words)
 
         if words[1] == 'PRIVMSG':

logging.json

@@ -5,19 +5,41 @@
     "standard": {
       "format": "%(asctime)s %(threadName)s %(levelname)s  %(module)s - %(message)s",
       "datefmt": "%Y-%m-%dT%H:%M:%S%z"
+    },
+    "message": {
+      "format": "%(asctime)s  %(message)s",
+      "datefmt": "%Y-%m-%dT%H:%M:%S%z"
     }
   },
   "handlers": {
     "stdout": {
       "class": "logging.StreamHandler",
       "formatter": "standard",
       "stream": "ext://sys.stdout"
+    },
+    "message": {
+      "class": "logging.handlers.RotatingFileHandler",
+      "formatter": "message",
+      "filename": "logs/messages.log",
+      "maxBytes": 10485760,
+      "backupCount": 10
     }
   },
   "loggers": {
     "root": {
-      "level": "DEBUG",
+      "level": "DEBUG"
+    },
+    "main": {
+      "handlers": ["stdout"]
+    },
+    "bot": {
+      "handlers": ["stdout"]
+    },
+    "action": {
       "handlers": ["stdout"]
+    },
+    "message": {
+      "handlers": ["message"]
     }
   }
 }