2016-07-15 08:19:07 -04:00
|
|
|
# -*- coding: utf-8 -*-
|
|
|
|
# Copyright 2016 OpenMarket Ltd
|
2019-07-25 11:08:24 -04:00
|
|
|
# Copyright 2019 New Vector Ltd
|
|
|
|
# Copyright 2019 The Matrix.org Foundation C.I.C.
|
2016-07-15 08:19:07 -04:00
|
|
|
#
|
|
|
|
# Licensed under the Apache License, Version 2.0 (the "License");
|
|
|
|
# you may not use this file except in compliance with the License.
|
|
|
|
# You may obtain a copy of the License at
|
|
|
|
#
|
|
|
|
# http://www.apache.org/licenses/LICENSE-2.0
|
|
|
|
#
|
|
|
|
# Unless required by applicable law or agreed to in writing, software
|
|
|
|
# distributed under the License is distributed on an "AS IS" BASIS,
|
|
|
|
# WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
|
|
|
|
# See the License for the specific language governing permissions and
|
|
|
|
# limitations under the License.
|
2018-07-09 02:09:20 -04:00
|
|
|
import logging
|
2020-07-17 07:09:25 -04:00
|
|
|
from typing import Any, Dict, List, Optional
|
2018-07-09 02:09:20 -04:00
|
|
|
|
2016-07-20 12:58:44 -04:00
|
|
|
from synapse.api import errors
|
2017-02-01 12:33:16 -05:00
|
|
|
from synapse.api.constants import EventTypes
|
2019-02-18 10:24:13 -05:00
|
|
|
from synapse.api.errors import (
|
|
|
|
FederationDeniedError,
|
|
|
|
HttpResponseException,
|
|
|
|
RequestSendFailed,
|
2020-02-10 16:35:26 -05:00
|
|
|
SynapseError,
|
2019-02-18 10:24:13 -05:00
|
|
|
)
|
2019-09-03 05:21:30 -04:00
|
|
|
from synapse.logging.opentracing import log_kv, set_tag, trace
|
2020-05-21 11:41:12 -04:00
|
|
|
from synapse.metrics.background_process_metrics import run_as_background_process
|
2020-06-01 11:47:30 -04:00
|
|
|
from synapse.types import (
|
|
|
|
RoomStreamToken,
|
2020-09-11 07:22:55 -04:00
|
|
|
StreamToken,
|
2020-06-01 11:47:30 -04:00
|
|
|
get_domain_from_id,
|
|
|
|
get_verify_key_from_cross_signing_key,
|
|
|
|
)
|
2016-07-15 08:19:07 -04:00
|
|
|
from synapse.util import stringutils
|
2018-08-10 09:50:21 -04:00
|
|
|
from synapse.util.async_helpers import Linearizer
|
2017-03-03 11:02:53 -05:00
|
|
|
from synapse.util.caches.expiringcache import ExpiringCache
|
2017-02-02 13:36:17 -05:00
|
|
|
from synapse.util.metrics import measure_func
|
2018-07-09 02:09:20 -04:00
|
|
|
from synapse.util.retryutils import NotRetryingDestination
|
2016-07-15 08:19:07 -04:00
|
|
|
|
2018-07-09 02:09:20 -04:00
|
|
|
from ._base import BaseHandler
|
2018-04-28 07:19:12 -04:00
|
|
|
|
2016-07-15 08:19:07 -04:00
|
|
|
logger = logging.getLogger(__name__)
|
|
|
|
|
2020-02-10 16:35:26 -05:00
|
|
|
MAX_DEVICE_DISPLAY_NAME_LEN = 100
|
|
|
|
|
2016-07-15 08:19:07 -04:00
|
|
|
|
2019-03-04 13:24:32 -05:00
|
|
|
class DeviceWorkerHandler(BaseHandler):
|
2016-07-15 08:19:07 -04:00
|
|
|
def __init__(self, hs):
|
2019-03-04 13:24:32 -05:00
|
|
|
super(DeviceWorkerHandler, self).__init__(hs)
|
2016-07-15 08:19:07 -04:00
|
|
|
|
2017-01-26 11:06:54 -05:00
|
|
|
self.hs = hs
|
2017-01-25 09:27:27 -05:00
|
|
|
self.state = hs.get_state_handler()
|
2019-10-23 12:25:54 -04:00
|
|
|
self.state_store = hs.get_storage().state
|
2017-11-01 06:29:34 -04:00
|
|
|
self._auth_handler = hs.get_auth_handler()
|
2019-03-04 13:24:32 -05:00
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
@trace
|
2020-07-17 07:09:25 -04:00
|
|
|
async def get_devices_by_user(self, user_id: str) -> List[Dict[str, Any]]:
|
2019-03-04 13:24:32 -05:00
|
|
|
"""
|
|
|
|
Retrieve the given user's devices
|
|
|
|
|
|
|
|
Args:
|
2020-07-17 07:09:25 -04:00
|
|
|
user_id: The user ID to query for devices.
|
2019-03-04 13:24:32 -05:00
|
|
|
Returns:
|
2020-07-17 07:09:25 -04:00
|
|
|
info on each device
|
2019-03-04 13:24:32 -05:00
|
|
|
"""
|
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
set_tag("user_id", user_id)
|
2020-07-17 07:09:25 -04:00
|
|
|
device_map = await self.store.get_devices_by_user(user_id)
|
2019-03-04 13:24:32 -05:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
ips = await self.store.get_last_client_ip_by_device(user_id, device_id=None)
|
2019-03-04 13:24:32 -05:00
|
|
|
|
|
|
|
devices = list(device_map.values())
|
|
|
|
for device in devices:
|
|
|
|
_update_device_from_client_ips(device, ips)
|
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
log_kv(device_map)
|
2019-07-23 09:00:55 -04:00
|
|
|
return devices
|
2019-03-04 13:24:32 -05:00
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
@trace
|
2020-07-17 07:09:25 -04:00
|
|
|
async def get_device(self, user_id: str, device_id: str) -> Dict[str, Any]:
|
2019-03-04 13:24:32 -05:00
|
|
|
""" Retrieve the given device
|
|
|
|
|
|
|
|
Args:
|
2020-07-17 07:09:25 -04:00
|
|
|
user_id: The user to get the device from
|
|
|
|
device_id: The device to fetch.
|
2019-03-04 13:24:32 -05:00
|
|
|
|
|
|
|
Returns:
|
2020-07-17 07:09:25 -04:00
|
|
|
info on the device
|
2019-03-04 13:24:32 -05:00
|
|
|
Raises:
|
|
|
|
errors.NotFoundError: if the device was not found
|
|
|
|
"""
|
|
|
|
try:
|
2020-07-17 07:09:25 -04:00
|
|
|
device = await self.store.get_device(user_id, device_id)
|
2019-03-04 13:24:32 -05:00
|
|
|
except errors.StoreError:
|
|
|
|
raise errors.NotFoundError
|
2020-07-17 07:09:25 -04:00
|
|
|
ips = await self.store.get_last_client_ip_by_device(user_id, device_id)
|
2019-03-04 13:24:32 -05:00
|
|
|
_update_device_from_client_ips(device, ips)
|
2019-09-03 05:21:30 -04:00
|
|
|
|
|
|
|
set_tag("device", device)
|
|
|
|
set_tag("ips", ips)
|
|
|
|
|
2019-07-23 09:00:55 -04:00
|
|
|
return device
|
2019-03-04 13:24:32 -05:00
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
@trace
|
2020-07-17 07:09:25 -04:00
|
|
|
@measure_func("device.get_user_ids_changed")
|
2020-09-11 07:22:55 -04:00
|
|
|
async def get_user_ids_changed(self, user_id: str, from_token: StreamToken):
|
2019-03-04 13:24:32 -05:00
|
|
|
"""Get list of users that have had the devices updated, or have newly
|
|
|
|
joined a room, that `user_id` may be interested in.
|
|
|
|
"""
|
2019-09-03 05:21:30 -04:00
|
|
|
|
|
|
|
set_tag("user_id", user_id)
|
|
|
|
set_tag("from_token", from_token)
|
2020-09-11 07:22:55 -04:00
|
|
|
now_room_id = self.store.get_room_max_stream_ordering()
|
|
|
|
now_room_key = RoomStreamToken(None, now_room_id)
|
2019-03-04 13:24:32 -05:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
room_ids = await self.store.get_rooms_for_user(user_id)
|
2019-03-04 13:24:32 -05:00
|
|
|
|
2019-06-26 06:56:52 -04:00
|
|
|
# First we check if any devices have changed for users that we share
|
|
|
|
# rooms with.
|
2020-07-17 07:09:25 -04:00
|
|
|
users_who_share_room = await self.store.get_users_who_share_room_with_user(
|
2020-03-30 05:18:33 -04:00
|
|
|
user_id
|
|
|
|
)
|
2020-03-30 05:11:26 -04:00
|
|
|
|
|
|
|
tracked_users = set(users_who_share_room)
|
2020-03-30 09:00:11 -04:00
|
|
|
|
|
|
|
# Always tell the user about their own devices
|
2020-03-27 08:26:47 -04:00
|
|
|
tracked_users.add(user_id)
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
changed = await self.store.get_users_whose_devices_changed(
|
2020-03-27 08:26:47 -04:00
|
|
|
from_token.device_list_key, tracked_users
|
|
|
|
)
|
|
|
|
|
2019-03-04 13:24:32 -05:00
|
|
|
# Then work out if any users have since joined
|
|
|
|
rooms_changed = self.store.get_rooms_that_changed(room_ids, from_token.room_key)
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
member_events = await self.store.get_membership_changes_for_user(
|
2019-06-20 05:32:02 -04:00
|
|
|
user_id, from_token.room_key, now_room_key
|
2019-03-04 13:24:32 -05:00
|
|
|
)
|
|
|
|
rooms_changed.update(event.room_id for event in member_events)
|
|
|
|
|
2020-09-11 07:22:55 -04:00
|
|
|
stream_ordering = from_token.room_key.stream
|
2019-03-04 13:24:32 -05:00
|
|
|
|
|
|
|
possibly_changed = set(changed)
|
|
|
|
possibly_left = set()
|
|
|
|
for room_id in rooms_changed:
|
2020-07-17 07:09:25 -04:00
|
|
|
current_state_ids = await self.store.get_current_state_ids(room_id)
|
2019-03-04 13:24:32 -05:00
|
|
|
|
|
|
|
# The user may have left the room
|
|
|
|
# TODO: Check if they actually did or if we were just invited.
|
|
|
|
if room_id not in room_ids:
|
2020-06-15 07:03:36 -04:00
|
|
|
for key, event_id in current_state_ids.items():
|
2019-03-04 13:24:32 -05:00
|
|
|
etype, state_key = key
|
|
|
|
if etype != EventTypes.Member:
|
|
|
|
continue
|
|
|
|
possibly_left.add(state_key)
|
|
|
|
continue
|
|
|
|
|
|
|
|
# Fetch the current state at the time.
|
|
|
|
try:
|
2020-07-17 07:09:25 -04:00
|
|
|
event_ids = await self.store.get_forward_extremeties_for_room(
|
2019-03-04 13:24:32 -05:00
|
|
|
room_id, stream_ordering=stream_ordering
|
|
|
|
)
|
|
|
|
except errors.StoreError:
|
|
|
|
# we have purged the stream_ordering index since the stream
|
|
|
|
# ordering: treat it the same as a new room
|
|
|
|
event_ids = []
|
|
|
|
|
|
|
|
# special-case for an empty prev state: include all members
|
|
|
|
# in the changed list
|
|
|
|
if not event_ids:
|
2019-09-03 05:21:30 -04:00
|
|
|
log_kv(
|
|
|
|
{"event": "encountered empty previous state", "room_id": room_id}
|
|
|
|
)
|
2020-06-15 07:03:36 -04:00
|
|
|
for key, event_id in current_state_ids.items():
|
2019-03-04 13:24:32 -05:00
|
|
|
etype, state_key = key
|
|
|
|
if etype != EventTypes.Member:
|
|
|
|
continue
|
|
|
|
possibly_changed.add(state_key)
|
|
|
|
continue
|
|
|
|
|
|
|
|
current_member_id = current_state_ids.get((EventTypes.Member, user_id))
|
|
|
|
if not current_member_id:
|
|
|
|
continue
|
|
|
|
|
|
|
|
# mapping from event_id -> state_dict
|
2020-07-17 07:09:25 -04:00
|
|
|
prev_state_ids = await self.state_store.get_state_ids_for_events(event_ids)
|
2019-03-04 13:24:32 -05:00
|
|
|
|
|
|
|
# Check if we've joined the room? If so we just blindly add all the users to
|
|
|
|
# the "possibly changed" users.
|
2020-06-15 07:03:36 -04:00
|
|
|
for state_dict in prev_state_ids.values():
|
2019-03-04 13:24:32 -05:00
|
|
|
member_event = state_dict.get((EventTypes.Member, user_id), None)
|
|
|
|
if not member_event or member_event != current_member_id:
|
2020-06-15 07:03:36 -04:00
|
|
|
for key, event_id in current_state_ids.items():
|
2019-03-04 13:24:32 -05:00
|
|
|
etype, state_key = key
|
|
|
|
if etype != EventTypes.Member:
|
|
|
|
continue
|
|
|
|
possibly_changed.add(state_key)
|
|
|
|
break
|
|
|
|
|
|
|
|
# If there has been any change in membership, include them in the
|
|
|
|
# possibly changed list. We'll check if they are joined below,
|
|
|
|
# and we're not toooo worried about spuriously adding users.
|
2020-06-15 07:03:36 -04:00
|
|
|
for key, event_id in current_state_ids.items():
|
2019-03-04 13:24:32 -05:00
|
|
|
etype, state_key = key
|
|
|
|
if etype != EventTypes.Member:
|
|
|
|
continue
|
|
|
|
|
|
|
|
# check if this member has changed since any of the extremities
|
|
|
|
# at the stream_ordering, and add them to the list if so.
|
2020-06-15 07:03:36 -04:00
|
|
|
for state_dict in prev_state_ids.values():
|
2019-03-04 13:24:32 -05:00
|
|
|
prev_event_id = state_dict.get(key, None)
|
|
|
|
if not prev_event_id or prev_event_id != event_id:
|
|
|
|
if state_key != user_id:
|
|
|
|
possibly_changed.add(state_key)
|
|
|
|
break
|
|
|
|
|
|
|
|
if possibly_changed or possibly_left:
|
|
|
|
# Take the intersection of the users whose devices may have changed
|
|
|
|
# and those that actually still share a room with the user
|
2020-03-30 05:11:26 -04:00
|
|
|
possibly_joined = possibly_changed & users_who_share_room
|
|
|
|
possibly_left = (possibly_changed | possibly_left) - users_who_share_room
|
2019-03-04 13:24:32 -05:00
|
|
|
else:
|
|
|
|
possibly_joined = []
|
|
|
|
possibly_left = []
|
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
result = {"changed": list(possibly_joined), "left": list(possibly_left)}
|
|
|
|
|
|
|
|
log_kv(result)
|
|
|
|
|
|
|
|
return result
|
2019-03-04 13:24:32 -05:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
async def on_federation_query_user_devices(self, user_id):
|
2020-09-01 07:41:21 -04:00
|
|
|
stream_id, devices = await self.store.get_e2e_device_keys_for_federation_query(
|
|
|
|
user_id
|
|
|
|
)
|
2020-07-17 07:09:25 -04:00
|
|
|
master_key = await self.store.get_e2e_cross_signing_key(user_id, "master")
|
|
|
|
self_signing_key = await self.store.get_e2e_cross_signing_key(
|
2020-02-07 10:45:39 -05:00
|
|
|
user_id, "self_signing"
|
|
|
|
)
|
|
|
|
|
|
|
|
return {
|
|
|
|
"user_id": user_id,
|
|
|
|
"stream_id": stream_id,
|
|
|
|
"devices": devices,
|
|
|
|
"master_key": master_key,
|
|
|
|
"self_signing_key": self_signing_key,
|
|
|
|
}
|
|
|
|
|
2019-03-04 13:24:32 -05:00
|
|
|
|
|
|
|
class DeviceHandler(DeviceWorkerHandler):
|
|
|
|
def __init__(self, hs):
|
|
|
|
super(DeviceHandler, self).__init__(hs)
|
|
|
|
|
2017-01-26 11:06:54 -05:00
|
|
|
self.federation_sender = hs.get_federation_sender()
|
2017-03-01 09:12:11 -05:00
|
|
|
|
2019-07-29 11:34:44 -04:00
|
|
|
self.device_list_updater = DeviceListUpdater(hs, self)
|
2017-01-26 11:06:54 -05:00
|
|
|
|
2018-03-12 12:17:08 -04:00
|
|
|
federation_registry = hs.get_federation_registry()
|
|
|
|
|
|
|
|
federation_registry.register_edu_handler(
|
2019-07-29 11:34:44 -04:00
|
|
|
"m.device_list_update", self.device_list_updater.incoming_device_list_update
|
2017-01-26 11:06:54 -05:00
|
|
|
)
|
2017-01-25 09:27:27 -05:00
|
|
|
|
2017-01-26 11:39:33 -05:00
|
|
|
hs.get_distributor().observe("user_left_room", self.user_left_room)
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
async def check_device_registered(
|
2019-06-20 05:32:02 -04:00
|
|
|
self, user_id, device_id, initial_device_display_name=None
|
|
|
|
):
|
2016-07-15 08:19:07 -04:00
|
|
|
"""
|
|
|
|
If the given device has not been registered, register it with the
|
|
|
|
supplied display name.
|
|
|
|
|
|
|
|
If no device_id is supplied, we make one up.
|
|
|
|
|
|
|
|
Args:
|
|
|
|
user_id (str): @user:id
|
|
|
|
device_id (str | None): device id supplied by client
|
|
|
|
initial_device_display_name (str | None): device display name from
|
|
|
|
client
|
|
|
|
Returns:
|
|
|
|
str: device id (generated if none was supplied)
|
|
|
|
"""
|
|
|
|
if device_id is not None:
|
2020-07-17 07:09:25 -04:00
|
|
|
new_device = await self.store.store_device(
|
2016-07-15 08:19:07 -04:00
|
|
|
user_id=user_id,
|
|
|
|
device_id=device_id,
|
|
|
|
initial_device_display_name=initial_device_display_name,
|
|
|
|
)
|
2017-01-25 09:27:27 -05:00
|
|
|
if new_device:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.notify_device_update(user_id, [device_id])
|
2019-07-23 09:00:55 -04:00
|
|
|
return device_id
|
2016-07-15 08:19:07 -04:00
|
|
|
|
|
|
|
# if the device id is not specified, we'll autogen one, but loop a few
|
|
|
|
# times in case of a clash.
|
|
|
|
attempts = 0
|
|
|
|
while attempts < 5:
|
2017-01-25 09:27:27 -05:00
|
|
|
device_id = stringutils.random_string(10).upper()
|
2020-07-17 07:09:25 -04:00
|
|
|
new_device = await self.store.store_device(
|
2017-01-25 09:27:27 -05:00
|
|
|
user_id=user_id,
|
|
|
|
device_id=device_id,
|
|
|
|
initial_device_display_name=initial_device_display_name,
|
|
|
|
)
|
|
|
|
if new_device:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.notify_device_update(user_id, [device_id])
|
2019-07-23 09:00:55 -04:00
|
|
|
return device_id
|
2017-01-25 09:27:27 -05:00
|
|
|
attempts += 1
|
2016-07-15 08:19:07 -04:00
|
|
|
|
2016-07-20 12:58:44 -04:00
|
|
|
raise errors.StoreError(500, "Couldn't generate a device ID.")
|
2016-07-20 11:34:00 -04:00
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
@trace
|
2020-07-17 07:09:25 -04:00
|
|
|
async def delete_device(self, user_id: str, device_id: str) -> None:
|
2016-07-22 09:52:53 -04:00
|
|
|
""" Delete the given device
|
|
|
|
|
|
|
|
Args:
|
2020-07-17 07:09:25 -04:00
|
|
|
user_id: The user to delete the device from.
|
|
|
|
device_id: The device to delete.
|
2016-07-22 09:52:53 -04:00
|
|
|
"""
|
|
|
|
|
|
|
|
try:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.delete_device(user_id, device_id)
|
2018-03-15 11:11:17 -04:00
|
|
|
except errors.StoreError as e:
|
2016-07-22 09:52:53 -04:00
|
|
|
if e.code == 404:
|
|
|
|
# no match
|
2019-09-03 05:21:30 -04:00
|
|
|
set_tag("error", True)
|
|
|
|
log_kv(
|
|
|
|
{"reason": "User doesn't have device id.", "device_id": device_id}
|
|
|
|
)
|
2016-07-22 09:52:53 -04:00
|
|
|
pass
|
|
|
|
else:
|
|
|
|
raise
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
await self._auth_handler.delete_access_tokens_for_user(
|
|
|
|
user_id, device_id=device_id
|
2016-07-26 06:09:47 -04:00
|
|
|
)
|
2016-07-22 09:52:53 -04:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.delete_e2e_keys_by_device(user_id=user_id, device_id=device_id)
|
2016-07-27 07:18:03 -04:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.notify_device_update(user_id, [device_id])
|
2017-01-25 09:27:27 -05:00
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
@trace
|
2020-07-17 07:09:25 -04:00
|
|
|
async def delete_all_devices_for_user(
|
|
|
|
self, user_id: str, except_device_id: Optional[str] = None
|
|
|
|
) -> None:
|
2017-11-29 10:44:59 -05:00
|
|
|
"""Delete all of the user's devices
|
|
|
|
|
|
|
|
Args:
|
2020-07-17 07:09:25 -04:00
|
|
|
user_id: The user to remove all devices from
|
|
|
|
except_device_id: optional device id which should not be deleted
|
2017-11-29 10:44:59 -05:00
|
|
|
"""
|
2020-07-17 07:09:25 -04:00
|
|
|
device_map = await self.store.get_devices_by_user(user_id)
|
2018-05-31 05:03:47 -04:00
|
|
|
device_ids = list(device_map)
|
2017-11-29 10:44:59 -05:00
|
|
|
if except_device_id is not None:
|
|
|
|
device_ids = [d for d in device_ids if d != except_device_id]
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.delete_devices(user_id, device_ids)
|
2017-11-29 10:44:59 -05:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
async def delete_devices(self, user_id: str, device_ids: List[str]) -> None:
|
2017-03-13 13:53:23 -04:00
|
|
|
""" Delete several devices
|
|
|
|
|
|
|
|
Args:
|
2020-07-17 07:09:25 -04:00
|
|
|
user_id: The user to delete devices from.
|
|
|
|
device_ids: The list of device IDs to delete
|
2017-03-13 13:53:23 -04:00
|
|
|
"""
|
|
|
|
|
|
|
|
try:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.delete_devices(user_id, device_ids)
|
2018-03-15 11:11:17 -04:00
|
|
|
except errors.StoreError as e:
|
2017-03-13 13:53:23 -04:00
|
|
|
if e.code == 404:
|
|
|
|
# no match
|
2019-09-03 05:21:30 -04:00
|
|
|
set_tag("error", True)
|
|
|
|
set_tag("reason", "User doesn't have that device id.")
|
2017-03-13 13:53:23 -04:00
|
|
|
pass
|
|
|
|
else:
|
|
|
|
raise
|
|
|
|
|
|
|
|
# Delete access tokens and e2e keys for each device. Not optimised as it is not
|
|
|
|
# considered as part of a critical path.
|
|
|
|
for device_id in device_ids:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self._auth_handler.delete_access_tokens_for_user(
|
|
|
|
user_id, device_id=device_id
|
2017-03-13 13:53:23 -04:00
|
|
|
)
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.delete_e2e_keys_by_device(
|
2017-03-13 13:53:23 -04:00
|
|
|
user_id=user_id, device_id=device_id
|
|
|
|
)
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.notify_device_update(user_id, device_ids)
|
2017-03-13 13:53:23 -04:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
async def update_device(self, user_id: str, device_id: str, content: dict) -> None:
|
2016-07-25 12:51:24 -04:00
|
|
|
""" Update the given device
|
|
|
|
|
|
|
|
Args:
|
2020-07-17 07:09:25 -04:00
|
|
|
user_id: The user to update devices of.
|
|
|
|
device_id: The device to update.
|
|
|
|
content: body of update request
|
2016-07-25 12:51:24 -04:00
|
|
|
"""
|
|
|
|
|
2020-02-10 16:35:26 -05:00
|
|
|
# Reject a new displayname which is too long.
|
|
|
|
new_display_name = content.get("display_name")
|
|
|
|
if new_display_name and len(new_display_name) > MAX_DEVICE_DISPLAY_NAME_LEN:
|
|
|
|
raise SynapseError(
|
|
|
|
400,
|
|
|
|
"Device display name is too long (max %i)"
|
|
|
|
% (MAX_DEVICE_DISPLAY_NAME_LEN,),
|
|
|
|
)
|
|
|
|
|
2016-07-25 12:51:24 -04:00
|
|
|
try:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.update_device(
|
2020-02-10 16:35:26 -05:00
|
|
|
user_id, device_id, new_display_name=new_display_name
|
2016-07-25 12:51:24 -04:00
|
|
|
)
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.notify_device_update(user_id, [device_id])
|
2018-03-15 11:11:17 -04:00
|
|
|
except errors.StoreError as e:
|
2016-07-25 12:51:24 -04:00
|
|
|
if e.code == 404:
|
|
|
|
raise errors.NotFoundError()
|
|
|
|
else:
|
|
|
|
raise
|
2016-07-22 09:52:53 -04:00
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
@trace
|
2017-02-02 13:36:17 -05:00
|
|
|
@measure_func("notify_device_update")
|
2020-07-17 07:09:25 -04:00
|
|
|
async def notify_device_update(self, user_id, device_ids):
|
2017-01-26 11:30:37 -05:00
|
|
|
"""Notify that a user's device(s) has changed. Pokes the notifier, and
|
|
|
|
remote servers if the user is local.
|
|
|
|
"""
|
2020-07-17 09:11:05 -04:00
|
|
|
if not device_ids:
|
|
|
|
# No changes to notify about, so this is a no-op.
|
|
|
|
return
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
users_who_share_room = await self.store.get_users_who_share_room_with_user(
|
2017-02-02 10:25:00 -05:00
|
|
|
user_id
|
|
|
|
)
|
2017-01-25 09:27:27 -05:00
|
|
|
|
|
|
|
hosts = set()
|
2017-01-26 11:06:54 -05:00
|
|
|
if self.hs.is_mine_id(user_id):
|
2017-02-02 10:25:00 -05:00
|
|
|
hosts.update(get_domain_from_id(u) for u in users_who_share_room)
|
2017-01-26 11:06:54 -05:00
|
|
|
hosts.discard(self.server_name)
|
2017-01-25 09:27:27 -05:00
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
set_tag("target_hosts", hosts)
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
position = await self.store.add_device_change_to_streams(
|
2017-01-26 11:06:54 -05:00
|
|
|
user_id, device_ids, list(hosts)
|
2017-01-25 09:27:27 -05:00
|
|
|
)
|
|
|
|
|
2020-07-17 09:11:05 -04:00
|
|
|
if not position:
|
|
|
|
# This should only happen if there are no updates, so we bail.
|
|
|
|
return
|
|
|
|
|
2019-03-07 10:53:14 -05:00
|
|
|
for device_id in device_ids:
|
|
|
|
logger.debug(
|
2019-06-20 05:32:02 -04:00
|
|
|
"Notifying about update %r/%r, ID: %r", user_id, device_id, position
|
2019-03-07 10:53:14 -05:00
|
|
|
)
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
room_ids = await self.store.get_rooms_for_user(user_id)
|
2017-02-02 10:25:00 -05:00
|
|
|
|
2020-03-27 08:26:47 -04:00
|
|
|
# specify the user ID too since the user should always get their own device list
|
|
|
|
# updates, even if they aren't in any rooms.
|
2020-07-17 07:09:25 -04:00
|
|
|
self.notifier.on_new_event(
|
2020-03-27 08:35:32 -04:00
|
|
|
"device_list_key", position, users=[user_id], rooms=room_ids
|
|
|
|
)
|
2017-01-25 09:27:27 -05:00
|
|
|
|
2017-01-26 11:30:37 -05:00
|
|
|
if hosts:
|
2019-06-20 05:32:02 -04:00
|
|
|
logger.info(
|
|
|
|
"Sending device list update notif for %r to: %r", user_id, hosts
|
|
|
|
)
|
2017-01-26 11:30:37 -05:00
|
|
|
for host in hosts:
|
|
|
|
self.federation_sender.send_device_messages(host)
|
2019-09-03 05:21:30 -04:00
|
|
|
log_kv({"message": "sent device update to host", "host": host})
|
2017-01-25 09:27:27 -05:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
async def notify_user_signature_update(
|
|
|
|
self, from_user_id: str, user_ids: List[str]
|
|
|
|
) -> None:
|
2019-07-25 11:08:24 -04:00
|
|
|
"""Notify a user that they have made new signatures of other users.
|
|
|
|
|
|
|
|
Args:
|
2020-07-17 07:09:25 -04:00
|
|
|
from_user_id: the user who made the signature
|
|
|
|
user_ids: the users IDs that have new signatures
|
2019-07-25 11:08:24 -04:00
|
|
|
"""
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
position = await self.store.add_user_signature_change_to_streams(
|
2019-07-25 11:08:24 -04:00
|
|
|
from_user_id, user_ids
|
|
|
|
)
|
|
|
|
|
|
|
|
self.notifier.on_new_event("device_list_key", position, users=[from_user_id])
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
async def user_left_room(self, user, room_id):
|
2017-03-01 09:12:11 -05:00
|
|
|
user_id = user.to_string()
|
2020-07-17 07:09:25 -04:00
|
|
|
room_ids = await self.store.get_rooms_for_user(user_id)
|
2017-03-16 07:51:46 -04:00
|
|
|
if not room_ids:
|
2017-03-01 09:12:11 -05:00
|
|
|
# We no longer share rooms with this user, so we'll no longer
|
|
|
|
# receive device updates. Mark this in DB.
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.mark_remote_user_device_list_as_unsubscribed(user_id)
|
2017-03-01 09:12:11 -05:00
|
|
|
|
|
|
|
|
|
|
|
def _update_device_from_client_ips(device, client_ips):
|
|
|
|
ip = client_ips.get((device["user_id"], device["device_id"]), {})
|
2019-06-20 05:32:02 -04:00
|
|
|
device.update({"last_seen_ts": ip.get("last_seen"), "last_seen_ip": ip.get("ip")})
|
2017-03-01 09:12:11 -05:00
|
|
|
|
|
|
|
|
2020-09-04 06:54:56 -04:00
|
|
|
class DeviceListUpdater:
|
2017-03-01 09:12:11 -05:00
|
|
|
"Handles incoming device list updates from federation and updates the DB"
|
|
|
|
|
|
|
|
def __init__(self, hs, device_handler):
|
|
|
|
self.store = hs.get_datastore()
|
2018-03-13 09:26:52 -04:00
|
|
|
self.federation = hs.get_federation_client()
|
2017-03-01 09:12:11 -05:00
|
|
|
self.clock = hs.get_clock()
|
|
|
|
self.device_handler = device_handler
|
|
|
|
|
2017-03-03 10:31:57 -05:00
|
|
|
self._remote_edu_linearizer = Linearizer(name="remote_device_list")
|
2017-03-01 09:12:11 -05:00
|
|
|
|
|
|
|
# user_id -> list of updates waiting to be handled.
|
|
|
|
self._pending_updates = {}
|
|
|
|
|
|
|
|
# Recently seen stream ids. We don't bother keeping these in the DB,
|
|
|
|
# but they're useful to have them about to reduce the number of spurious
|
|
|
|
# resyncs.
|
2017-03-03 11:02:53 -05:00
|
|
|
self._seen_updates = ExpiringCache(
|
|
|
|
cache_name="device_update_edu",
|
|
|
|
clock=self.clock,
|
|
|
|
max_len=10000,
|
|
|
|
expiry_ms=30 * 60 * 1000,
|
|
|
|
iterable=True,
|
|
|
|
)
|
2017-03-01 09:12:11 -05:00
|
|
|
|
2020-05-21 11:41:12 -04:00
|
|
|
# Attempt to resync out of sync device lists every 30s.
|
|
|
|
self._resync_retry_in_progress = False
|
|
|
|
self.clock.looping_call(
|
|
|
|
run_as_background_process,
|
|
|
|
30 * 1000,
|
|
|
|
func=self._maybe_retry_device_resync,
|
|
|
|
desc="_maybe_retry_device_resync",
|
|
|
|
)
|
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
@trace
|
2020-07-17 07:09:25 -04:00
|
|
|
async def incoming_device_list_update(self, origin, edu_content):
|
2017-03-01 09:12:11 -05:00
|
|
|
"""Called on incoming device list update from federation. Responsible
|
|
|
|
for parsing the EDU and adding to pending updates list.
|
|
|
|
"""
|
|
|
|
|
2019-09-03 05:21:30 -04:00
|
|
|
set_tag("origin", origin)
|
|
|
|
set_tag("edu_content", edu_content)
|
2017-03-01 09:12:11 -05:00
|
|
|
user_id = edu_content.pop("user_id")
|
|
|
|
device_id = edu_content.pop("device_id")
|
|
|
|
stream_id = str(edu_content.pop("stream_id")) # They may come as ints
|
|
|
|
prev_ids = edu_content.pop("prev_id", [])
|
2019-06-20 05:32:02 -04:00
|
|
|
prev_ids = [str(p) for p in prev_ids] # They may come as ints
|
2017-01-26 11:06:54 -05:00
|
|
|
|
|
|
|
if get_domain_from_id(user_id) != origin:
|
|
|
|
# TODO: Raise?
|
2019-03-07 10:53:14 -05:00
|
|
|
logger.warning(
|
|
|
|
"Got device list update edu for %r/%r from %r",
|
2019-06-20 05:32:02 -04:00
|
|
|
user_id,
|
|
|
|
device_id,
|
|
|
|
origin,
|
2019-03-07 10:53:14 -05:00
|
|
|
)
|
2019-09-03 05:21:30 -04:00
|
|
|
|
|
|
|
set_tag("error", True)
|
|
|
|
log_kv(
|
|
|
|
{
|
|
|
|
"message": "Got a device list update edu from a user and "
|
|
|
|
"device which does not match the origin of the request.",
|
|
|
|
"user_id": user_id,
|
|
|
|
"device_id": device_id,
|
|
|
|
}
|
|
|
|
)
|
2017-01-26 11:06:54 -05:00
|
|
|
return
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
room_ids = await self.store.get_rooms_for_user(user_id)
|
2017-03-16 07:51:46 -04:00
|
|
|
if not room_ids:
|
2017-01-26 11:39:33 -05:00
|
|
|
# We don't share any rooms with this user. Ignore update, as we
|
|
|
|
# probably won't get any further updates.
|
2019-09-03 05:21:30 -04:00
|
|
|
set_tag("error", True)
|
|
|
|
log_kv(
|
|
|
|
{
|
|
|
|
"message": "Got an update from a user for which "
|
|
|
|
"we don't share any rooms",
|
|
|
|
"other user_id": user_id,
|
|
|
|
}
|
|
|
|
)
|
2019-03-07 10:53:14 -05:00
|
|
|
logger.warning(
|
|
|
|
"Got device list update edu for %r/%r, but don't share a room",
|
2019-06-20 05:32:02 -04:00
|
|
|
user_id,
|
|
|
|
device_id,
|
2019-03-07 10:53:14 -05:00
|
|
|
)
|
2017-01-26 11:39:33 -05:00
|
|
|
return
|
2017-01-26 11:06:54 -05:00
|
|
|
|
2019-06-20 05:32:02 -04:00
|
|
|
logger.debug("Received device list update for %r/%r", user_id, device_id)
|
2019-03-07 10:53:14 -05:00
|
|
|
|
2017-03-01 09:12:11 -05:00
|
|
|
self._pending_updates.setdefault(user_id, []).append(
|
|
|
|
(device_id, stream_id, prev_ids, edu_content)
|
|
|
|
)
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
await self._handle_device_updates(user_id)
|
2017-03-01 09:12:11 -05:00
|
|
|
|
|
|
|
@measure_func("_incoming_device_list_update")
|
2020-07-17 07:09:25 -04:00
|
|
|
async def _handle_device_updates(self, user_id):
|
2017-03-01 09:12:11 -05:00
|
|
|
"Actually handle pending updates."
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
with (await self._remote_edu_linearizer.queue(user_id)):
|
2017-03-01 09:12:11 -05:00
|
|
|
pending_updates = self._pending_updates.pop(user_id, [])
|
|
|
|
if not pending_updates:
|
|
|
|
# This can happen since we batch updates
|
|
|
|
return
|
|
|
|
|
2019-03-07 10:53:14 -05:00
|
|
|
for device_id, stream_id, prev_ids, content in pending_updates:
|
|
|
|
logger.debug(
|
|
|
|
"Handling update %r/%r, ID: %r, prev: %r ",
|
2019-06-20 05:32:02 -04:00
|
|
|
user_id,
|
|
|
|
device_id,
|
|
|
|
stream_id,
|
|
|
|
prev_ids,
|
2019-03-07 10:53:14 -05:00
|
|
|
)
|
|
|
|
|
2017-05-05 05:59:32 -04:00
|
|
|
# Given a list of updates we check if we need to resync. This
|
|
|
|
# happens if we've missed updates.
|
2020-07-17 07:09:25 -04:00
|
|
|
resync = await self._need_to_do_resync(user_id, pending_updates)
|
2017-01-26 11:06:54 -05:00
|
|
|
|
2020-02-05 09:02:39 -05:00
|
|
|
if logger.isEnabledFor(logging.INFO):
|
|
|
|
logger.info(
|
|
|
|
"Received device list update for %s, requiring resync: %s. Devices: %s",
|
|
|
|
user_id,
|
|
|
|
resync,
|
|
|
|
", ".join(u[0] for u in pending_updates),
|
|
|
|
)
|
2019-03-07 10:53:14 -05:00
|
|
|
|
2017-01-26 11:06:54 -05:00
|
|
|
if resync:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.user_device_resync(user_id)
|
2017-01-26 11:06:54 -05:00
|
|
|
else:
|
2017-01-26 11:30:37 -05:00
|
|
|
# Simply update the single device, since we know that is the only
|
2018-07-10 12:58:09 -04:00
|
|
|
# change (because of the single prev_id matching the current cache)
|
2017-03-01 09:12:11 -05:00
|
|
|
for device_id, stream_id, prev_ids, content in pending_updates:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.update_remote_device_list_cache_entry(
|
2019-06-20 05:32:02 -04:00
|
|
|
user_id, device_id, content, stream_id
|
2017-03-01 09:12:11 -05:00
|
|
|
)
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.device_handler.notify_device_update(
|
2017-03-01 09:12:11 -05:00
|
|
|
user_id, [device_id for device_id, _, _, _ in pending_updates]
|
2017-01-26 11:06:54 -05:00
|
|
|
)
|
|
|
|
|
2019-03-07 11:04:24 -05:00
|
|
|
self._seen_updates.setdefault(user_id, set()).update(
|
|
|
|
stream_id for _, stream_id, _, _ in pending_updates
|
|
|
|
)
|
2017-01-26 11:06:54 -05:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
async def _need_to_do_resync(self, user_id, updates):
|
2017-03-01 09:12:11 -05:00
|
|
|
"""Given a list of updates for a user figure out if we need to do a full
|
|
|
|
resync, or whether we have enough data that we can just apply the delta.
|
|
|
|
"""
|
|
|
|
seen_updates = self._seen_updates.get(user_id, set())
|
2017-01-26 11:39:33 -05:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
extremity = await self.store.get_device_list_last_stream_id_for_remote(user_id)
|
2016-07-20 12:58:44 -04:00
|
|
|
|
2019-06-20 05:32:02 -04:00
|
|
|
logger.debug("Current extremity for %r: %r", user_id, extremity)
|
2019-03-07 10:53:14 -05:00
|
|
|
|
2017-03-01 09:12:11 -05:00
|
|
|
stream_id_in_updates = set() # stream_ids in updates list
|
|
|
|
for _, stream_id, prev_ids, _ in updates:
|
|
|
|
if not prev_ids:
|
|
|
|
# We always do a resync if there are no previous IDs
|
2019-07-23 09:00:55 -04:00
|
|
|
return True
|
2017-03-01 09:12:11 -05:00
|
|
|
|
|
|
|
for prev_id in prev_ids:
|
|
|
|
if prev_id == extremity:
|
|
|
|
continue
|
|
|
|
elif prev_id in seen_updates:
|
|
|
|
continue
|
|
|
|
elif prev_id in stream_id_in_updates:
|
|
|
|
continue
|
|
|
|
else:
|
2019-07-23 09:00:55 -04:00
|
|
|
return True
|
2017-03-01 09:12:11 -05:00
|
|
|
|
|
|
|
stream_id_in_updates.add(stream_id)
|
|
|
|
|
2019-07-23 09:00:55 -04:00
|
|
|
return False
|
2019-07-29 11:34:44 -04:00
|
|
|
|
2020-06-15 11:42:21 -04:00
|
|
|
@trace
|
2020-07-17 07:09:25 -04:00
|
|
|
async def _maybe_retry_device_resync(self):
|
2020-05-21 11:41:12 -04:00
|
|
|
"""Retry to resync device lists that are out of sync, except if another retry is
|
|
|
|
in progress.
|
|
|
|
"""
|
|
|
|
if self._resync_retry_in_progress:
|
|
|
|
return
|
|
|
|
|
|
|
|
try:
|
|
|
|
# Prevent another call of this function to retry resyncing device lists so
|
|
|
|
# we don't send too many requests.
|
|
|
|
self._resync_retry_in_progress = True
|
|
|
|
# Get all of the users that need resyncing.
|
2020-07-17 07:09:25 -04:00
|
|
|
need_resync = await self.store.get_user_ids_requiring_device_list_resync()
|
2020-05-21 11:41:12 -04:00
|
|
|
# Iterate over the set of user IDs.
|
|
|
|
for user_id in need_resync:
|
2020-06-01 06:55:14 -04:00
|
|
|
try:
|
|
|
|
# Try to resync the current user's devices list.
|
2020-07-17 07:09:25 -04:00
|
|
|
result = await self.user_device_resync(
|
2020-06-01 06:55:14 -04:00
|
|
|
user_id=user_id, mark_failed_as_stale=False,
|
|
|
|
)
|
|
|
|
|
|
|
|
# user_device_resync only returns a result if it managed to
|
|
|
|
# successfully resync and update the database. Updating the table
|
|
|
|
# of users requiring resync isn't necessary here as
|
|
|
|
# user_device_resync already does it (through
|
|
|
|
# self.store.update_remote_device_list_cache).
|
|
|
|
if result:
|
|
|
|
logger.debug(
|
|
|
|
"Successfully resynced the device list for %s", user_id,
|
|
|
|
)
|
|
|
|
except Exception as e:
|
|
|
|
# If there was an issue resyncing this user, e.g. if the remote
|
|
|
|
# server sent a malformed result, just log the error instead of
|
|
|
|
# aborting all the subsequent resyncs.
|
2020-05-21 11:41:12 -04:00
|
|
|
logger.debug(
|
2020-06-01 06:55:14 -04:00
|
|
|
"Could not resync the device list for %s: %s", user_id, e,
|
2020-05-21 11:41:12 -04:00
|
|
|
)
|
|
|
|
finally:
|
|
|
|
# Allow future calls to retry resyncinc out of sync device lists.
|
|
|
|
self._resync_retry_in_progress = False
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
async def user_device_resync(
|
|
|
|
self, user_id: str, mark_failed_as_stale: bool = True
|
|
|
|
) -> Optional[dict]:
|
2019-07-29 11:34:44 -04:00
|
|
|
"""Fetches all devices for a user and updates the device cache with them.
|
|
|
|
|
|
|
|
Args:
|
2020-07-17 07:09:25 -04:00
|
|
|
user_id: The user's id whose device_list will be updated.
|
|
|
|
mark_failed_as_stale: Whether to mark the user's device list as stale
|
2020-05-21 11:41:12 -04:00
|
|
|
if the attempt to resync failed.
|
2019-07-29 11:34:44 -04:00
|
|
|
Returns:
|
2020-07-17 07:09:25 -04:00
|
|
|
A dict with device info as under the "devices" in the result of this
|
2019-07-29 11:34:44 -04:00
|
|
|
request:
|
|
|
|
https://matrix.org/docs/spec/server_server/r0.1.2#get-matrix-federation-v1-user-devices-userid
|
|
|
|
"""
|
2020-06-01 06:55:14 -04:00
|
|
|
logger.debug("Attempting to resync the device list for %s", user_id)
|
2019-09-03 05:21:30 -04:00
|
|
|
log_kv({"message": "Doing resync to update device list."})
|
2019-07-29 11:34:44 -04:00
|
|
|
# Fetch all devices for the user.
|
|
|
|
origin = get_domain_from_id(user_id)
|
|
|
|
try:
|
2020-07-17 07:09:25 -04:00
|
|
|
result = await self.federation.query_user_devices(origin, user_id)
|
2020-05-21 11:41:12 -04:00
|
|
|
except NotRetryingDestination:
|
|
|
|
if mark_failed_as_stale:
|
|
|
|
# Mark the remote user's device list as stale so we know we need to retry
|
|
|
|
# it later.
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.mark_remote_user_device_cache_as_stale(user_id)
|
2020-05-21 11:41:12 -04:00
|
|
|
|
|
|
|
return
|
|
|
|
except (RequestSendFailed, HttpResponseException) as e:
|
|
|
|
logger.warning(
|
|
|
|
"Failed to handle device list update for %s: %s", user_id, e,
|
|
|
|
)
|
|
|
|
|
|
|
|
if mark_failed_as_stale:
|
|
|
|
# Mark the remote user's device list as stale so we know we need to retry
|
|
|
|
# it later.
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.mark_remote_user_device_cache_as_stale(user_id)
|
2020-05-21 11:41:12 -04:00
|
|
|
|
2019-07-29 11:34:44 -04:00
|
|
|
# We abort on exceptions rather than accepting the update
|
|
|
|
# as otherwise synapse will 'forget' that its device list
|
|
|
|
# is out of date. If we bail then we will retry the resync
|
|
|
|
# next time we get a device list update for this user_id.
|
|
|
|
# This makes it more likely that the device lists will
|
|
|
|
# eventually become consistent.
|
|
|
|
return
|
|
|
|
except FederationDeniedError as e:
|
2019-09-03 05:21:30 -04:00
|
|
|
set_tag("error", True)
|
|
|
|
log_kv({"reason": "FederationDeniedError"})
|
2019-07-29 11:34:44 -04:00
|
|
|
logger.info(e)
|
|
|
|
return
|
2019-09-03 05:21:30 -04:00
|
|
|
except Exception as e:
|
|
|
|
set_tag("error", True)
|
|
|
|
log_kv(
|
|
|
|
{"message": "Exception raised by federation request", "exception": e}
|
|
|
|
)
|
2019-07-29 11:34:44 -04:00
|
|
|
logger.exception("Failed to handle device list update for %s", user_id)
|
2020-05-21 11:41:12 -04:00
|
|
|
|
|
|
|
if mark_failed_as_stale:
|
|
|
|
# Mark the remote user's device list as stale so we know we need to retry
|
|
|
|
# it later.
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.mark_remote_user_device_cache_as_stale(user_id)
|
2020-05-21 11:41:12 -04:00
|
|
|
|
2019-07-29 11:34:44 -04:00
|
|
|
return
|
2019-09-03 05:21:30 -04:00
|
|
|
log_kv({"result": result})
|
2019-07-29 11:34:44 -04:00
|
|
|
stream_id = result["stream_id"]
|
|
|
|
devices = result["devices"]
|
|
|
|
|
2020-06-01 11:47:30 -04:00
|
|
|
# Get the master key and the self-signing key for this user if provided in the
|
|
|
|
# response (None if not in the response).
|
|
|
|
# The response will not contain the user signing key, as this key is only used by
|
|
|
|
# its owner, thus it doesn't make sense to send it over federation.
|
|
|
|
master_key = result.get("master_key")
|
|
|
|
self_signing_key = result.get("self_signing_key")
|
|
|
|
|
2019-07-29 11:34:44 -04:00
|
|
|
# If the remote server has more than ~1000 devices for this user
|
|
|
|
# we assume that something is going horribly wrong (e.g. a bot
|
|
|
|
# that logs in and creates a new device every time it tries to
|
|
|
|
# send a message). Maintaining lots of devices per user in the
|
|
|
|
# cache can cause serious performance issues as if this request
|
|
|
|
# takes more than 60s to complete, internal replication from the
|
|
|
|
# inbound federation worker to the synapse master may time out
|
|
|
|
# causing the inbound federation to fail and causing the remote
|
|
|
|
# server to retry, causing a DoS. So in this scenario we give
|
|
|
|
# up on storing the total list of devices and only handle the
|
|
|
|
# delta instead.
|
|
|
|
if len(devices) > 1000:
|
2019-10-31 06:23:24 -04:00
|
|
|
logger.warning(
|
2019-07-29 11:34:44 -04:00
|
|
|
"Ignoring device list snapshot for %s as it has >1K devs (%d)",
|
|
|
|
user_id,
|
|
|
|
len(devices),
|
|
|
|
)
|
|
|
|
devices = []
|
|
|
|
|
|
|
|
for device in devices:
|
|
|
|
logger.debug(
|
|
|
|
"Handling resync update %r/%r, ID: %r",
|
|
|
|
user_id,
|
|
|
|
device["device_id"],
|
|
|
|
stream_id,
|
|
|
|
)
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.update_remote_device_list_cache(user_id, devices, stream_id)
|
2019-07-29 11:34:44 -04:00
|
|
|
device_ids = [device["device_id"] for device in devices]
|
2020-06-01 11:47:30 -04:00
|
|
|
|
|
|
|
# Handle cross-signing keys.
|
2020-07-17 07:09:25 -04:00
|
|
|
cross_signing_device_ids = await self.process_cross_signing_key_update(
|
2020-06-01 11:47:30 -04:00
|
|
|
user_id, master_key, self_signing_key,
|
|
|
|
)
|
|
|
|
device_ids = device_ids + cross_signing_device_ids
|
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.device_handler.notify_device_update(user_id, device_ids)
|
2019-07-29 11:34:44 -04:00
|
|
|
|
|
|
|
# We clobber the seen updates since we've re-synced from a given
|
|
|
|
# point.
|
2020-02-21 07:15:07 -05:00
|
|
|
self._seen_updates[user_id] = {stream_id}
|
2019-07-29 11:34:44 -04:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
return result
|
2020-06-01 11:47:30 -04:00
|
|
|
|
2020-07-17 07:09:25 -04:00
|
|
|
async def process_cross_signing_key_update(
|
2020-06-01 11:47:30 -04:00
|
|
|
self,
|
|
|
|
user_id: str,
|
|
|
|
master_key: Optional[Dict[str, Any]],
|
|
|
|
self_signing_key: Optional[Dict[str, Any]],
|
|
|
|
) -> list:
|
|
|
|
"""Process the given new master and self-signing key for the given remote user.
|
|
|
|
|
|
|
|
Args:
|
|
|
|
user_id: The ID of the user these keys are for.
|
|
|
|
master_key: The dict of the cross-signing master key as returned by the
|
|
|
|
remote server.
|
|
|
|
self_signing_key: The dict of the cross-signing self-signing key as returned
|
|
|
|
by the remote server.
|
|
|
|
|
|
|
|
Return:
|
|
|
|
The device IDs for the given keys.
|
|
|
|
"""
|
|
|
|
device_ids = []
|
|
|
|
|
|
|
|
if master_key:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.set_e2e_cross_signing_key(user_id, "master", master_key)
|
2020-06-01 11:47:30 -04:00
|
|
|
_, verify_key = get_verify_key_from_cross_signing_key(master_key)
|
|
|
|
# verify_key is a VerifyKey from signedjson, which uses
|
|
|
|
# .version to denote the portion of the key ID after the
|
|
|
|
# algorithm and colon, which is the device ID
|
|
|
|
device_ids.append(verify_key.version)
|
|
|
|
if self_signing_key:
|
2020-07-17 07:09:25 -04:00
|
|
|
await self.store.set_e2e_cross_signing_key(
|
2020-06-01 11:47:30 -04:00
|
|
|
user_id, "self_signing", self_signing_key
|
|
|
|
)
|
|
|
|
_, verify_key = get_verify_key_from_cross_signing_key(self_signing_key)
|
|
|
|
device_ids.append(verify_key.version)
|
|
|
|
|
|
|
|
return device_ids
|