hemppa/bot.py

389 lines
14 KiB
Python
Raw Normal View History

2019-12-09 20:38:25 +02:00
#!/usr/bin/env python3
2019-12-09 19:54:57 +02:00
import asyncio
import functools
2019-12-09 20:24:51 +02:00
import glob
import importlib
import json
import yaml
2020-01-02 14:27:29 +02:00
import os
import re
import signal
2020-01-02 14:27:29 +02:00
import sys
import traceback
2019-12-10 18:05:40 +02:00
import urllib.parse
2020-02-08 23:16:19 +02:00
import logging
import logging.config
2020-02-02 23:08:15 +02:00
from importlib import reload
2020-01-02 14:27:29 +02:00
import requests
from nio import AsyncClient, InviteEvent, JoinError, RoomMessageText, MatrixRoom, LogoutResponse, LogoutError, \
LoginError
2020-02-02 23:08:15 +02:00
2019-12-09 19:54:57 +02:00
# Couple of custom exceptions
2020-01-02 14:27:29 +02:00
class CommandRequiresAdmin(Exception):
pass
2020-01-02 14:27:29 +02:00
class CommandRequiresOwner(Exception):
pass
2019-12-09 19:54:57 +02:00
2020-01-02 14:27:29 +02:00
2019-12-09 19:54:57 +02:00
class Bot:
2020-02-08 23:16:19 +02:00
def __init__(self):
self.appid = 'org.vranki.hemppa'
self.version = '1.2'
self.client = None
self.join_on_invite = False
self.modules = dict()
self.pollcount = 0
self.poll_task = None
self.owners = []
self.debug = os.getenv("DEBUG", "false").lower() == "true"
self.logger = None
2020-02-08 23:16:19 +02:00
self.initialize_logger()
2020-02-08 23:16:19 +02:00
def initialize_logger(self):
if os.path.exists('config/logging.yml'):
with open('config/logging.yml') as f:
config = yaml.load(f, Loader=yaml.Loader)
logging.config.dictConfig(config)
else:
log_format = '%(levelname)s - %(name)s - %(message)s'
logging.basicConfig(format=log_format)
self.logger = logging.getLogger("hemppa")
2020-02-08 23:16:19 +02:00
if self.debug:
logging.root.setLevel(logging.DEBUG)
self.logger.info("enabled debugging")
self.logger.debug("Logger initialized")
2020-02-08 23:16:19 +02:00
2019-12-09 20:24:51 +02:00
async def send_text(self, room, body):
2019-12-09 19:54:57 +02:00
msg = {
"body": body,
"msgtype": "m.text"
}
await self.client.room_send(room.room_id, 'm.room.message', msg)
2019-12-09 19:54:57 +02:00
2019-12-10 18:05:40 +02:00
async def send_html(self, room, html, plaintext):
msg = {
"msgtype": "m.text",
"format": "org.matrix.custom.html",
2019-12-10 18:05:40 +02:00
"formatted_body": html,
"body": plaintext
}
await self.client.room_send(room.room_id, 'm.room.message', msg)
2019-12-09 19:54:57 +02:00
def remove_callback(self, callback):
for cb_object in self.client.event_callbacks:
if cb_object.func == callback:
self.logger.info("remove callback")
self.client.event_callbacks.remove(cb_object)
2019-12-10 18:05:40 +02:00
def get_room_by_id(self, room_id):
return self.client.rooms[room_id]
# Throws exception if event sender is not a room admin
def must_be_admin(self, room, event):
if not self.is_admin(room, event):
raise CommandRequiresAdmin
# Throws exception if event sender is not a bot owner
def must_be_owner(self, event):
if not self.is_owner(event):
raise CommandRequiresOwner
2020-01-02 14:27:29 +02:00
# Returns true if event's sender is admin in the room event was sent in,
# or is bot owner
def is_admin(self, room, event):
2019-12-30 22:40:55 +02:00
if self.is_owner(event):
return True
2020-01-02 14:27:29 +02:00
if event.sender not in room.power_levels.users:
return False
return room.power_levels.users[event.sender] >= 50
# Returns true if event's sender is owner of the bot
def is_owner(self, event):
return event.sender in self.owners
2019-12-10 18:05:40 +02:00
def save_settings(self):
module_settings = dict()
for modulename, moduleobject in self.modules.items():
try:
module_settings[modulename] = moduleobject.get_settings()
except Exception:
traceback.print_exc(file=sys.stderr)
2020-01-02 14:27:29 +02:00
data = {self.appid: self.version, 'module_settings': module_settings}
2019-12-10 18:05:40 +02:00
self.set_account_data(data)
def load_settings(self, data):
if not data:
return
2019-12-10 18:05:40 +02:00
if not data.get('module_settings'):
return
for modulename, moduleobject in self.modules.items():
if data['module_settings'].get(modulename):
try:
moduleobject.set_settings(
data['module_settings'][modulename])
except Exception:
traceback.print_exc(file=sys.stderr)
2019-12-10 18:05:40 +02:00
2019-12-09 19:54:57 +02:00
async def message_cb(self, room, event):
2019-12-09 20:24:51 +02:00
# Figure out the command
body = event.body
if not self.starts_with_command(body):
return
2019-12-09 20:24:51 +02:00
command = body.split().pop(0)
# Strip away non-alphanumeric characters, including leading ! for security
command = re.sub(r'\W+', '', command)
moduleobject = self.modules.get(command)
2020-02-07 18:54:36 +02:00
if moduleobject is not None:
if moduleobject.enabled:
try:
await moduleobject.matrix_message(self, room, event)
2020-02-07 18:54:36 +02:00
except CommandRequiresAdmin:
await self.send_text(room, f'Sorry, you need admin power level in this room to run that command.')
except CommandRequiresOwner:
await self.send_text(room, f'Sorry, only bot owner can run that command.')
except Exception:
2020-02-08 23:16:19 +02:00
await self.send_text(room, f'Module {command} experienced difficulty: {sys.exc_info()[0]} - see log for details')
2020-02-07 18:54:36 +02:00
traceback.print_exc(file=sys.stderr)
else:
2020-02-08 23:16:19 +02:00
self.logger.error(f"Unknown command: {command}")
# TODO Make this configurable
# await self.send_text(room,
# f"Sorry. I don't know what to do. Execute !help to get a list of available commands.")
2019-12-09 19:54:57 +02:00
@staticmethod
def starts_with_command(body):
"""Checks if body starts with ! and has one or more letters after it"""
return re.match(r"^!\w.*", body) is not None
2019-12-09 19:54:57 +02:00
async def invite_cb(self, room, event):
room: MatrixRoom
event: InviteEvent
if self.join_on_invite or self.is_owner(event):
for attempt in range(3):
result = await self.client.join(room.room_id)
if type(result) == JoinError:
2020-02-08 23:16:19 +02:00
self.logger.error(f"Error joining room %s (attempt %d): %s", room.room_id, attempt, result.message)
else:
2020-02-08 23:16:19 +02:00
self.logger.info(f"joining room '{room.display_name}'({room.room_id}) invited by '{event.sender}'")
break
else:
2020-02-08 23:16:19 +02:00
self.logger.warning(f'Received invite event, but not joining as sender is not owner or bot not configured to join on invite. {event}')
2019-12-09 19:54:57 +02:00
2019-12-09 20:24:51 +02:00
def load_module(self, modulename):
try:
2020-02-08 23:16:19 +02:00
self.logger.info(f'load module: {modulename}')
2019-12-09 20:24:51 +02:00
module = importlib.import_module('modules.' + modulename)
module = reload(module)
2019-12-09 20:24:51 +02:00
cls = getattr(module, 'MatrixModule')
return cls(modulename)
2019-12-09 20:24:51 +02:00
except ModuleNotFoundError:
2020-02-08 23:16:19 +02:00
self.logger.error(f'Module {modulename} failed to load!')
2019-12-09 20:24:51 +02:00
traceback.print_exc(file=sys.stderr)
return None
def reload_modules(self):
for modulename in self.modules:
2020-02-08 23:16:19 +02:00
self.logger.info(f'Reloading {modulename} ..')
self.modules[modulename] = self.load_module(modulename)
self.load_settings(self.get_account_data())
2019-12-09 20:24:51 +02:00
def get_modules(self):
modulefiles = glob.glob('./modules/*.py')
for modulefile in modulefiles:
modulename = os.path.splitext(os.path.basename(modulefile))[0]
moduleobject = self.load_module(modulename)
if moduleobject:
self.modules[modulename] = moduleobject
2020-02-02 23:08:15 +02:00
def clear_modules(self):
self.modules = dict()
2019-12-09 20:24:51 +02:00
async def poll_timer(self):
while True:
self.pollcount = self.pollcount + 1
for modulename, moduleobject in self.modules.items():
if moduleobject.enabled:
try:
await moduleobject.matrix_poll(self, self.pollcount)
except Exception:
traceback.print_exc(file=sys.stderr)
await asyncio.sleep(10)
2019-12-10 18:05:40 +02:00
def set_account_data(self, data):
userid = urllib.parse.quote(self.matrix_user)
2019-12-10 18:05:40 +02:00
ad_url = f"{self.client.homeserver}/_matrix/client/r0/user/{userid}/account_data/{self.appid}?access_token={self.client.access_token}"
response = requests.put(ad_url, json.dumps(data))
self.__handle_error_response(response)
2019-12-10 18:05:40 +02:00
if response.status_code != 200:
2020-02-08 23:16:19 +02:00
self.logger.error('Setting account data failed. response: %s json: %s', response, response.json())
2019-12-10 18:05:40 +02:00
def get_account_data(self):
userid = urllib.parse.quote(self.matrix_user)
2019-12-10 18:05:40 +02:00
ad_url = f"{self.client.homeserver}/_matrix/client/r0/user/{userid}/account_data/{self.appid}?access_token={self.client.access_token}"
response = requests.get(ad_url)
self.__handle_error_response(response)
2019-12-10 18:05:40 +02:00
if response.status_code == 200:
return response.json()
2020-02-08 23:16:19 +02:00
self.logger.error(f'Getting account data failed: {response} {response.json()} - this is normal if you have not saved any settings yet.')
2019-12-10 19:03:19 +02:00
return None
2019-12-10 18:05:40 +02:00
def __handle_error_response(self, response):
if response.status_code == 401:
2020-02-08 23:16:19 +02:00
self.logger.error("access token is invalid or missing")
self.logger.info("NOTE: check MATRIX_ACCESS_TOKEN or set MATRIX_PASSWORD")
sys.exit(2)
2019-12-09 19:54:57 +02:00
def init(self):
self.matrix_user = os.getenv('MATRIX_USER')
self.matrix_pass = os.getenv('MATRIX_PASSWORD')
matrix_server = os.getenv('MATRIX_SERVER')
bot_owners = os.getenv('BOT_OWNERS')
access_token = os.getenv('MATRIX_ACCESS_TOKEN')
join_on_invite = os.getenv('JOIN_ON_INVITE')
if matrix_server and self.matrix_user and bot_owners:
self.client = AsyncClient(matrix_server, self.matrix_user)
self.client.access_token = access_token
if self.client.access_token is None:
if self.matrix_pass is None:
2020-02-08 23:16:19 +02:00
self.logger.error("Either MATRIX_ACCESS_TOKEN or MATRIX_PASSWORD need to be set")
sys.exit(1)
self.join_on_invite = join_on_invite is not None
self.owners = bot_owners.split(',')
self.get_modules()
else:
2020-02-08 23:16:19 +02:00
self.logger.error("The environment variables MATRIX_SERVER, MATRIX_USER and BOT_OWNERS are mandatory")
sys.exit(1)
def start(self):
self.load_settings(self.get_account_data())
enabled_modules = [module for module_name, module in self.modules.items() if module.enabled]
2020-02-08 23:16:19 +02:00
self.logger.info(f'Starting {len(enabled_modules)} modules..')
for modulename, moduleobject in self.modules.items():
if moduleobject.enabled:
try:
moduleobject.matrix_start(self)
except Exception:
traceback.print_exc(file=sys.stderr)
2019-12-09 20:24:51 +02:00
def stop(self):
2020-02-08 23:16:19 +02:00
self.logger.info(f'Stopping {len(self.modules)} modules..')
2019-12-09 20:24:51 +02:00
for modulename, moduleobject in self.modules.items():
try:
moduleobject.matrix_stop(self)
except Exception:
traceback.print_exc(file=sys.stderr)
2019-12-09 20:24:51 +02:00
2019-12-09 19:54:57 +02:00
async def run(self):
if not self.client.access_token:
login_response = await self.client.login(self.matrix_pass)
if isinstance(login_response, LoginError):
2020-02-08 23:16:19 +02:00
self.logger.error(f"Failed to login: {login_response.message}")
return
last_16 = self.client.access_token[-16:]
2020-02-08 23:16:19 +02:00
self.logger.info(f"Logged in with password, access token: ...{last_16}")
2019-12-09 19:54:57 +02:00
await self.client.sync()
for roomid, room in self.client.rooms.items():
2020-02-08 23:16:19 +02:00
self.logger.info(f"Bot is on '{room.display_name}'({roomid}) with {len(room.users)} users")
if len(room.users) == 1:
2020-02-08 23:16:19 +02:00
self.logger.info(f'Room {roomid} has no other users - leaving it.')
self.logger.info(await self.client.room_leave(roomid))
2019-12-11 00:04:24 +02:00
self.start()
2019-12-11 00:04:24 +02:00
self.poll_task = asyncio.get_event_loop().create_task(self.poll_timer())
2019-12-09 19:54:57 +02:00
if self.client.logged_in:
2019-12-10 18:05:40 +02:00
self.load_settings(self.get_account_data())
2019-12-09 19:54:57 +02:00
self.client.add_event_callback(self.message_cb, RoomMessageText)
self.client.add_event_callback(self.invite_cb, (InviteEvent,))
2019-12-09 19:54:57 +02:00
if self.join_on_invite:
2020-02-08 23:16:19 +02:00
self.logger.info('Note: Bot will join rooms if invited')
self.logger.info('Bot running as %s, owners %s', self.client.user, self.owners)
self.bot_task = asyncio.create_task(self.client.sync_forever(timeout=30000))
await self.bot_task
2019-12-09 19:54:57 +02:00
else:
2020-02-08 23:16:19 +02:00
self.logger.error('Client was not able to log in, check env variables!')
2019-12-09 19:54:57 +02:00
async def shutdown(self):
await self.logout()
await self.close()
async def logout(self):
if self.matrix_pass is not None and self.client.logged_in:
response = await self.client.logout()
if isinstance(response, LogoutResponse):
2020-02-08 23:16:19 +02:00
self.logger.info("Logout successful")
else:
self.logger.error(f"Logout unsuccessful. msg: {response.message}")
async def close(self):
try:
await self.client.close()
self.logger.info("Connection closed")
except Exception as ex:
self.logger.error("error while closing client: %s", ex)
def handle_exit(self, signame, loop):
self.logger.info(f"Received signal {signame}")
if self.poll_task:
self.poll_task.cancel()
self.bot_task.cancel()
self.stop()
async def main():
bot = Bot()
bot.init()
loop = asyncio.get_running_loop()
for signame in {'SIGINT', 'SIGTERM'}:
loop.add_signal_handler(
getattr(signal, signame),
functools.partial(bot.handle_exit, signame, loop))
await bot.run()
await bot.shutdown()
2019-12-09 20:24:51 +02:00
try:
asyncio.run(main())
except Exception as e:
print(e)