container-test-run-matrix-synapse
default.checks.aarch64-linux.matrix-synapse
· build #311
· raw
1additionally exposed symbols:2 machine,3 start_all, machines, driver, Machine, wait_for_signal4Starting machine5678<<< NixOS Stage 2 >>>910booting system configuration /nix/store/qh3alxamc7xj0hav5shv40j96apmqx9a-nixos-system-machine-test11running activation script...12setting up /etc...132: host0@if3: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN mode DEFAULT group default qlen 100014 link/ether 0e:74:26:22:81:c2 brd ff:ff:ff:ff:ff:ff link-netnsid 015setting up age secrets...16starting systemd...17systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)18Detected virtualization systemd-nspawn.19Detected architecture arm64.20Detected first boot.21Initializing machine ID from container UUID.22Applying preset policy.23Populated /etc with preset unit settings.24Queued start job for default target Multi-User System.25262728<<< Welcome to NixOS test (aarch64) - console >>>29+ systemd-run /bin/sh -c '/nix/store/p79fmimbb698sv4c135kbdwlhjcqpd3p-coreutils-9.11/bin/sleep 999999999 && echo cd797dc8-9c9e-4ae6-a19a-f7ec486ad56a'30Running as unit: run-p485-i84260876.service; invocation ID: 1ec3eaaef455435ca024afc810ae010f31To attach to container machine run on the same machine that runs the test:32 sudo nsenter --user --target $(\pgrep -f '^/bin/sh.*cd797dc8-9c9e-4ae6-a19a-f7ec486ad56a') --mount --uts --ipc --net --pid --cgroup /bin/sh -c bash 3334To inject external network and continue test, run:35sudo /nix/store/41m77i1296n33p6liin8ynr6wh3h6b7m-python3-3.14.6/bin/python3.14 /nix/store/5kaq06rm8h6acj0ggm4f0dswwr131zib-test-driver-0.0.1/lib/python3.14/site-packages/test_driver/inject_network.py cd797dc8-9c9e-4ae6-a19a-f7ec486ad56a36+ systemctl --no-pager show matrix-synapse37+ systemctl --no-pager show matrix-synapse38+ systemctl --no-pager show matrix-synapse39+ systemctl --no-pager show matrix-synapse40+ systemctl --no-pager show matrix-synapse41+ systemctl --no-pager show matrix-synapse42+ systemctl --no-pager show matrix-synapse43+ systemctl --no-pager show matrix-synapse44+ nc -z -v ::1 800845Connection to ::1 8008 port [tcp/http-alt] succeeded!46machine: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'47+ curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'48(finished: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test', in 0.01 seconds)49+ systemctl restart matrix-synapse50+ journalctl -u matrix-synapse --no-pager51Aug 11 10:09:02 machine systemd[1]: Starting Synapse Matrix homeserver...52Aug 11 10:09:05 machine matrix-synapse-pre-start[480]: Generating signing key file /var/lib/matrix-synapse/homeserver.signing.key53Aug 11 10:09:08 machine synapse_homeserver[495]: This server is configured to use 'matrix.org' as its trusted key server via the54Aug 11 10:09:08 machine synapse_homeserver[495]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key55Aug 11 10:09:08 machine synapse_homeserver[495]: server since it is long-lived, stable and trusted. However, some admins may56Aug 11 10:09:08 machine synapse_homeserver[495]: wish to use another server for this purpose.57Aug 11 10:09:08 machine synapse_homeserver[495]: To suppress this warning and continue using 'matrix.org', admins should set58Aug 11 10:09:08 machine synapse_homeserver[495]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.59Aug 11 10:09:08 machine synapse_homeserver[495]: --------------------------------------------------------------------------------60Aug 11 10:09:08 machine synapse[495]: synapse.config.logger: [main] ***** STARTING SERVER *****61Aug 11 10:09:08 machine synapse[495]: synapse.config.logger: [main] Server /nix/store/yda1713740c4n1fhqi2fb8fpngk9i024-matrix-synapse-1.158.0/bin/synapse_homeserver version 1.158.062Aug 11 10:09:08 machine synapse[495]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc63Aug 11 10:09:08 machine synapse[495]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse64Aug 11 10:09:08 machine synapse[495]: synapse.config.logger: [main] Server hostname: clan.test65Aug 11 10:09:08 machine synapse[495]: synapse.config.logger: [main] Public Base URL: https://clan.test/66Aug 11 10:09:08 machine synapse[495]: synapse.config.logger: [main] Instance name: master67Aug 11 10:09:08 machine synapse[495]: synapse.config.logger: [main] Twisted reactor: EPollReactor68Aug 11 10:09:08 machine synapse[495]: synapse.app.homeserver: [main] Setting up server69Aug 11 10:09:08 machine synapse[495]: synapse.server: [main] Setting up.70Aug 11 10:09:08 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: Checking database server71Aug 11 10:09:08 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']72Aug 11 10:09:08 machine synapse[495]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version73Aug 11 10:09:08 machine synapse[495]: synapse.storage.prepare_database: [main] ['main', 'state']: Initialising new database74Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v7375Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/01event_failed_pull_attempts.sql76Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/02add_pusher_enabled.sql77Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/02room_id_indexes_for_purging.sql78Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/03pusher_device_id.sql79Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/03users_approved_column.sql80Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/04partial_join_details.sql81Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/04pending_device_list_updates.sql82Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/05old_push_actions.sql.postgres83Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/06thread_notifications_thread_id_idx.sql84Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/08thread_receipts_non_null.sql.postgres85Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/09partial_joined_via_destination.sql86Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/09threads_table.sql87Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Running 73/10_update_sqlite_fts4_tokenizer.py:run_create88Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/10login_tokens.sql89Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/11event_search_room_id_n_distinct.sql.postgres90Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/12refactor_device_list_outbound_pokes.sql91Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/13add_device_lists_index.sql92Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/20_un_partial_stated_room_stream.sql93Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/21_un_partial_stated_room_stream_seq.sql.postgres94Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/22_rebuild_user_dir_stats.sql95Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/22_un_partial_stated_event_stream.sql96Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/23_fix_thread_index.sql97Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/23_un_partial_stated_room_stream_seq.sql.postgres98Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/24_events_jump_to_date_index.sql99Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/25drop_presence.sql100Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v74101Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/01_user_directory_stale_remote_users.sql102Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/02_set_device_id_for_pushers_bg_update.sql103Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/03_membership_tables_event_stream_ordering.sql.postgres104Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/03_room_membership_index.sql105Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/04_delete_e2e_backup_keys_for_deactivated_users.sql106Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Running 74/04_membership_tables_event_stream_ordering_triggers.py:run_create107Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/05_events_txn_id_device_id.sql108Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/90COMMENTS_destinations.sql.postgres109Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v75110Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v76111Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 76/01_add_profiles_full_user_id_column.sql112Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 76/02_add_user_filters_full_user_id_column.sql113Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 76/03_per_user_experimental_features.sql114Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 76/04_add_room_forgetter.sql115Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v77116Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/01_add_profiles_not_valid_check.sql.postgres117Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/02_add_user_filters_not_valid_check.sql.postgres118Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 77/03bg_populate_full_user_id_profiles.sql119Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 77/04bg_populate_full_user_id_user_filters.sql120Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 77/05thread_notifications_backfill.sql121Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions.sql.postgres122Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions_staging.sql.postgres123Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_summary.sql.postgres124Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 77/14bg_indices_event_stream_ordering.sql125Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v78126Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Running 78/03event_extremities_constraints.py:run_create127Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Running 78/04_add_full_user_id_index_user_filters.py:run_create128Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v79129Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/03_read_write_locks_triggers.sql.postgres130Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Running 79/04_mitigate_stream_ordering_update_race.py:run_create131Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/05_read_write_locks_triggers.sql.postgres132Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v80133Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 80/01_users_alter_locked.sql134Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/02_read_write_locks_unlogged.sql.postgres135Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 80/02_scheduled_tasks.sql136Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/03_read_write_locks_triggers.sql.postgres137Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/04_read_write_locks_deadlock.sql.postgres138Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v81139Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v82140Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 82/02_scheduled_tasks_index.sql141Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 82/04_add_indices_for_purging_rooms.sql142Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 82/05gaps.sql143Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v83144Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 83/01_drop_old_tables.sql145Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 83/05_cross_signing_key_update_grant.sql146Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 83/06_event_push_summary_room.sql147Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v84148Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/01_auth_links_stats.sql.postgres149Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 84/02_auth_links_index.sql150Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/03_auth_links_analyze.sql.postgres151Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 84/04_access_token_index.sql152Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v85153Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/01_add_suspended.sql154Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/02_add_instance_names.sql155Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 85/03_new_sequences.sql.postgres156Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/04_cleanup_device_federation_outbox.sql157Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/05_add_instance_names_converted_pos.sql158Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/06_add_room_reports.sql159Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v86160Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 86/01_authenticate_media.sql161Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 86/02_receipts_event_id_index.sql162Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v87163Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 87/01_sliding_sync_memberships.sql164Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 87/02_per_connection_state.sql165Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 87/03_current_state_index.sql166Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v88167Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/01_add_delayed_events.sql168Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/01_custom_profile_fields.sql169Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/02_fix_sliding_sync_membership_snapshots_forgotten_column.sql170Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/03_add_otk_ts_added_index.sql171Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/04_current_state_delta_index.sql172Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 88/05_drop_old_otks.sql.postgres173Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/05_sliding_sync_room_config_index.sql174Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/06_events_received_ts_index.sql175Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v89176Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 89/01_sliding_sync_membership_snapshot_index.sql177Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 89/01_state_groups_deletion.sql178Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v90179Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 90/01_add_column_participant_room_memberships_table.sql180Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 90/02_delete_unreferenced_state_groups.sql181Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 90/03_remove_old_deletion_bg_update.sql182Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v91183Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 91/01_media_hash.sql184Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v92185Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/01_remove_trigger.sql.postgres186Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/02_remove_populate_participant_bg_update.sql187Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/04_ss_membership_snapshot_idx.sql188Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/04_thread_subscriptions.sql189Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/04_thread_subscriptions_seq.sql.postgres190Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/05_fixup_max_depth_cap.sql191Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/05_thread_subscriptions_comments.sql.postgres192Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/06_device_federation_inbox_index.sql193Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/06_threads_last_sent_stream_ordering_comments.sql.postgres194Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/07_add_user_reports.sql195Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/07_event_txn_id_device_id_txn_id2.sql196Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/08_room_ban_redactions.sql197Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/08_thread_subscriptions_seq_fixup.sql.postgres198Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/09_thread_subscriptions_update.sql199Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/09_thread_subscriptions_update.sql.postgres200Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v93201Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 93/01_add_delayed_events.sql202Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 93/01_sticky_events.sql203Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 93/01_sticky_events_seq.sql.postgres204Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 93/02_sliding_sync_members.sql205Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 93/03_sss_pos_last_used.sql206Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Running 93/04_make_delayed_event_content_text.py:run_create207Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v94208Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/01_redactions_recheck.sql209Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/02_redactions_recheck_bg_update.sql210Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/03_device_lists_room_timestamp.sql211Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/03_quarantined_media_tracking.sql212Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/03_quarantined_media_tracking_seq.sql.postgres213Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/03_state_dag_fwd_extrems.sql214Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/04_device_lists_changes_max_pruned.sql215Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/05_rerun_flag_existing_quarantined_media.sql216Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/06_sliding_sync_connections_last_used_ts_index.sql217Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/07_sliding_sync_lazy_members_position_index.sql218Aug 11 10:09:09 machine synapse[495]: synapse.storage.prepare_database: [main] Schema now up to date219Aug 11 10:09:09 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database220Aug 11 10:09:09 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1221Aug 11 10:09:09 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1222Aug 11 10:09:09 machine synapse[495]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago223Aug 11 10:09:09 machine synapse[495]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0224Aug 11 10:09:09 machine synapse[495]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago225Aug 11 10:09:09 machine synapse[495]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0226Aug 11 10:09:09 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 1227Aug 11 10:09:09 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1228Aug 11 10:09:09 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1229Aug 11 10:09:09 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1230Aug 11 10:09:09 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1231Aug 11 10:09:09 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database232Aug 11 10:09:09 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: prepared233Aug 11 10:09:09 machine synapse[495]: synapse.server: [main] Finished setting up.234Aug 11 10:09:09 machine synapse[495]: twisted: [main] Redirected stdout/stderr to logs235Aug 11 10:09:09 machine synapse[495]: synapse.app.homeserver: [main] Running236Aug 11 10:09:09 machine synapse[495]: synapse.app.homeserver: [main] Set file limit to: 524288237Aug 11 10:09:09 machine synapse[495]: synapse.push.pusher: [call_when_running] email enable notifs: False238Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'239Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'240Aug 11 10:09:09 machine synapse[495]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds241Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'242Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'243Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'244Aug 11 10:09:09 machine synapse[495]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter245Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'246Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'247Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'248Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'249Aug 11 10:09:09 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'250Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffec6e3fa0> to path b'/health'251Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffec6fbca0> to path b'/_matrix/client'252Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffec8619a0> to path b'/.well-known'253Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffec6fbe20> to path b'/_synapse/admin'254Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffec861e20> to path b'/_synapse/client/pick_idp'255Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffec3a0c20> to path b'/_synapse/client/pick_username'256Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffec862420> to path b'/_synapse/client/new_user_consent'257Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffec8625a0> to path b'/_synapse/client/sso_register'258Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffec862720> to path b'/_synapse/client/unsubscribe'259Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.media_upload_limit_exceeded.MediaUploadLimitExceededResource object at 0xffffec8628a0> to path b'/_synapse/client/media_upload_limit_exceeded'260Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/yda1713740c4n1fhqi2fb8fpngk9i024-matrix-synapse-1.158.0/lib/python3.14/site-packages/synapse/static') to path b'/_matrix/static'261Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec862d20> to path b'/_matrix/media/r0'262Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec862d20> to path b'/_matrix/media/v3'263Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec862d20> to path b'/_matrix/media/v1'264Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffec863920> to path b'/_matrix/federation'265Aug 11 10:09:09 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffec866aa0> to path b'/_matrix/key'266Aug 11 10:09:09 machine synapse[495]: twisted: [call_when_running] SynapseSite starting on 8008267Aug 11 10:09:09 machine synapse[495]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008268Aug 11 10:09:09 machine synapse[495]: synapse.app._base: [call_when_running] garbage collector: Freezing all allocated objects in the hopes that (almost) everything currently allocated are things that will be used by the homeserver for the rest of time. Doing so means less work each GC (hopefully).269Aug 11 10:09:09 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master270Aug 11 10:09:09 machine synapse[495]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping271Aug 11 10:09:09 machine synapse[495]: synapse.push.pusherpool: [start_pushers-0] Started pushers272Aug 11 10:09:09 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[524]: Connection to ::1 8008 port [tcp/http-alt] succeeded!273Aug 11 10:09:10 machine synapse[495]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.001sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]274Aug 11 10:09:10 machine synapse[495]: synapse.handlers.auth: [POST-1] Logging in user @admin:clan.test on device TDRJUCTVGC275Aug 11 10:09:10 machine synapse[495]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.275sec/0.001sec ru=(0.244sec, 0.000sec) db=(0.004sec/0.025sec/12) 138B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]276Aug 11 10:09:10 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[525]: Sending registration request...277Aug 11 10:09:10 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[525]: Success!278Aug 11 10:09:10 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'threads_backfill'279Aug 11 10:09:10 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Running background update 'threads_backfill'. Processed 0 items in 7ms. (total_rate=None/ms, current_rate=None/ms, total_updated=0, batch_size=100)280Aug 11 10:09:11 machine synapse[495]: synapse.access.http.8008: [GET-2] ::1 - 8008 - {None} Processed request: 0.000sec/0.001sec ru=(0.001sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]281Aug 11 10:09:11 machine synapse[495]: synapse.handlers.auth: [POST-3] Logging in user @someuser:clan.test on device AYPJBPLMUS282Aug 11 10:09:11 machine synapse[495]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.287sec/0.000sec ru=(0.262sec, 0.000sec) db=(0.003sec/0.019sec/12) 145B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]283Aug 11 10:09:11 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[532]: Sending registration request...284Aug 11 10:09:11 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[532]: Success!285Aug 11 10:09:11 machine systemd[1]: Started Synapse Matrix homeserver.286Aug 11 10:09:11 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'device_lists_changes_in_room_by_room_index'287Aug 11 10:09:11 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Adding index device_lists_changes_in_room_by_room_idx to device_lists_changes_in_room288Aug 11 10:09:11 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Running background update 'device_lists_changes_in_room_by_room_index'. Processed 1 items in 4ms. (total_rate=0.25/ms, current_rate=0.25/ms, total_updated=1, batch_size=100)289Aug 11 10:09:12 machine synapse[495]: synapse.access.http.8008: [GET-4] ::1 - 8008 - {None} Processed request: 0.000sec/-0.000sec ru=(0.000sec, 0.000sec) db=(0.000sec/0.000sec/0) 10145B 200 "GET /_matrix/static/ HTTP/1.1" "curl/8.21.0" [0 dbevts]290Aug 11 10:09:12 machine systemd[1]: Stopping Synapse Matrix homeserver...291Aug 11 10:09:12 machine synapse[495]: twisted: [sentinel] Received SIGTERM, shutting down.292Aug 11 10:09:12 machine synapse[495]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropping held locks due to shutdown293Aug 11 10:09:12 machine synapse[495]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropped locks due to shutdown294Aug 11 10:09:12 machine synapse[495]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Performing _on_shutdown. Persisting 0 unpersisted changes295Aug 11 10:09:12 machine synapse[495]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Finished _on_shutdown296Aug 11 10:09:12 machine synapse[495]: synapse.app._base: [log_shutdown] Shutting down...297Aug 11 10:09:12 machine synapse[495]: twisted: [sentinel] (TCP Port 8008 Closed)298Aug 11 10:09:12 machine synapse[495]: twisted: [sentinel] Main loop terminated.299Aug 11 10:09:12 machine systemd[1]: matrix-synapse.service: Deactivated successfully.300Aug 11 10:09:12 machine systemd[1]: Stopped Synapse Matrix homeserver.301Aug 11 10:09:12 machine systemd[1]: matrix-synapse.service: Consumed 8.000s CPU time over 9.440s wall clock time.302Aug 11 10:09:12 machine systemd[1]: Starting Synapse Matrix homeserver...303Aug 11 10:09:18 machine synapse_homeserver[564]: This server is configured to use 'matrix.org' as its trusted key server via the304Aug 11 10:09:18 machine synapse_homeserver[564]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key305Aug 11 10:09:18 machine synapse_homeserver[564]: server since it is long-lived, stable and trusted. However, some admins may306Aug 11 10:09:18 machine synapse_homeserver[564]: wish to use another server for this purpose.307Aug 11 10:09:18 machine synapse_homeserver[564]: To suppress this warning and continue using 'matrix.org', admins should set308Aug 11 10:09:18 machine synapse_homeserver[564]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.309Aug 11 10:09:18 machine synapse_homeserver[564]: --------------------------------------------------------------------------------310Aug 11 10:09:18 machine synapse[564]: synapse.config.logger: [main] ***** STARTING SERVER *****311Aug 11 10:09:18 machine synapse[564]: synapse.config.logger: [main] Server /nix/store/yda1713740c4n1fhqi2fb8fpngk9i024-matrix-synapse-1.158.0/bin/synapse_homeserver version 1.158.0312Aug 11 10:09:18 machine synapse[564]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc313Aug 11 10:09:18 machine synapse[564]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse314Aug 11 10:09:18 machine synapse[564]: synapse.config.logger: [main] Server hostname: clan.test315Aug 11 10:09:18 machine synapse[564]: synapse.config.logger: [main] Public Base URL: https://clan.test/316Aug 11 10:09:18 machine synapse[564]: synapse.config.logger: [main] Instance name: master317Aug 11 10:09:18 machine synapse[564]: synapse.config.logger: [main] Twisted reactor: EPollReactor318Aug 11 10:09:18 machine synapse[564]: synapse.app.homeserver: [main] Setting up server319Aug 11 10:09:18 machine synapse[564]: synapse.server: [main] Setting up.320Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases: [main] [database config 'master']: Checking database server321Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']322Aug 11 10:09:18 machine synapse[564]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version323Aug 11 10:09:18 machine synapse[564]: synapse.storage.prepare_database: [main] ['main', 'state']: Existing schema is 94 (+10 deltas)324Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases.main: [main] Checking database for consistency with configuration...325Aug 11 10:09:18 machine synapse[564]: synapse.storage.prepare_database: [main] Applying schema deltas for v94326Aug 11 10:09:18 machine synapse[564]: synapse.storage.prepare_database: [main] Schema now up to date327Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database328Aug 11 10:09:18 machine synapse[564]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1329Aug 11 10:09:18 machine synapse[564]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1330Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago331Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0332Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago333Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0334Aug 11 10:09:18 machine synapse[564]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 3335Aug 11 10:09:18 machine synapse[564]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1336Aug 11 10:09:18 machine synapse[564]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1337Aug 11 10:09:18 machine synapse[564]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1338Aug 11 10:09:18 machine synapse[564]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1339Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database340Aug 11 10:09:18 machine synapse[564]: synapse.storage.databases: [main] [database config 'master']: prepared341Aug 11 10:09:18 machine synapse[564]: synapse.server: [main] Finished setting up.342Aug 11 10:09:18 machine synapse[564]: twisted: [main] Redirected stdout/stderr to logs343Aug 11 10:09:18 machine synapse[564]: synapse.app.homeserver: [main] Running344Aug 11 10:09:18 machine synapse[564]: synapse.app.homeserver: [main] Set file limit to: 524288345Aug 11 10:09:18 machine synapse[564]: synapse.push.pusher: [call_when_running] email enable notifs: False346Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'347Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'348Aug 11 10:09:18 machine synapse[564]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds349Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'350Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'351Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'352Aug 11 10:09:18 machine synapse[564]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter353Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'354Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'355Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'356Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'357Aug 11 10:09:18 machine synapse[564]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'358Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffec6a4720> to path b'/health'359Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffec6bc420> to path b'/_matrix/client'360Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffec862120> to path b'/.well-known'361Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffec6bc5a0> to path b'/_synapse/admin'362Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffec8625a0> to path b'/_synapse/client/pick_idp'363Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffec3413a0> to path b'/_synapse/client/pick_username'364Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffec862ba0> to path b'/_synapse/client/new_user_consent'365Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffec862d20> to path b'/_synapse/client/sso_register'366Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffec862ea0> to path b'/_synapse/client/unsubscribe'367Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.media_upload_limit_exceeded.MediaUploadLimitExceededResource object at 0xffffec863020> to path b'/_synapse/client/media_upload_limit_exceeded'368Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/yda1713740c4n1fhqi2fb8fpngk9i024-matrix-synapse-1.158.0/lib/python3.14/site-packages/synapse/static') to path b'/_matrix/static'369Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec8634a0> to path b'/_matrix/media/r0'370Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec8634a0> to path b'/_matrix/media/v3'371Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec8634a0> to path b'/_matrix/media/v1'372Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffec8640a0> to path b'/_matrix/federation'373Aug 11 10:09:18 machine synapse[564]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffec867220> to path b'/_matrix/key'374Aug 11 10:09:18 machine synapse[564]: twisted: [call_when_running] SynapseSite starting on 8008375Aug 11 10:09:18 machine synapse[564]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008376Aug 11 10:09:18 machine synapse[564]: synapse.app._base: [call_when_running] garbage collector: Freezing all allocated objects in the hopes that (almost) everything currently allocated are things that will be used by the homeserver for the rest of time. Doing so means less work each GC (hopefully).377Aug 11 10:09:18 machine synapse[564]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master378Aug 11 10:09:18 machine synapse[564]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping379Aug 11 10:09:18 machine synapse[564]: synapse.push.pusherpool: [start_pushers-0] Started pushers380Aug 11 10:09:18 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[589]: Connection to ::1 8008 port [tcp/http-alt] succeeded!381Aug 11 10:09:19 machine synapse[564]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.002sec, 0.001sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]382Aug 11 10:09:19 machine synapse[564]: synapse.http.server: [POST-1] <XForwardedForRequest at 0xffffec33c4e0 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.383Aug 11 10:09:19 machine synapse[564]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.235sec/0.000sec ru=(0.229sec, 0.000sec) db=(0.000sec/0.001sec/1) 60B 400 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]384Aug 11 10:09:19 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[590]: Sending registration request...385Aug 11 10:09:19 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[590]: User already exists. Skipping.386Aug 11 10:09:19 machine synapse[564]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'populate_stats_process_rooms'387Aug 11 10:09:19 machine synapse[564]: synapse.storage.background_updates: [background_updates-0] Running background update 'populate_stats_process_rooms'. Processed 1 items in 5ms. (total_rate=0.2/ms, current_rate=0.2/ms, total_updated=1, batch_size=100)388Aug 11 10:09:19 machine synapse[564]: synapse.access.http.8008: [GET-2] ::1 - 8008 - {None} Processed request: 0.000sec/0.000sec ru=(0.000sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]389Aug 11 10:09:20 machine synapse[564]: synapse.http.server: [POST-3] <XForwardedForRequest at 0xffffec314760 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.390Aug 11 10:09:20 machine synapse[564]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.240sec/0.000sec ru=(0.236sec, 0.000sec) db=(0.000sec/0.001sec/1) 60B 400 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]391Aug 11 10:09:20 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[596]: Sending registration request...392Aug 11 10:09:20 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[596]: User already exists. Skipping.393Aug 11 10:09:20 machine systemd[1]: Started Synapse Matrix homeserver.394+ systemctl --no-pager show matrix-synapse395+ nc -z -v ::1 8008396Connection to ::1 8008 port [tcp/http-alt] succeeded!397+ curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'398