container-test-run-matrix-synapse
checks.aarch64-linux.matrix-synapse
· build #465
· raw
1additionally exposed symbols:2 machine,3 start_all, machines, driver, Machine, wait_for_signal4Starting machine567<<< NixOS Stage 2 >>>89booting system configuration /nix/store/q0zwxk6nw9gamf1fz5gy0r9sn52c5g1a-nixos-system-machine-test10running activation script...11setting up /etc...122: host0@if3: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN mode DEFAULT group default qlen 100013 link/ether 0e:74:26:22:81:c2 brd ff:ff:ff:ff:ff:ff link-netnsid 014setting up age secrets...15starting systemd...16systemd 260.2 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)17Detected virtualization systemd-nspawn.18Detected architecture arm64.19Detected first boot.20Initializing machine ID from container UUID.21Applying preset policy.22Populated /etc with preset unit settings.23Queued start job for default target Multi-User System.24252627<<< Welcome to NixOS test (aarch64) - console >>>28+ systemd-run /bin/sh -c '/nix/store/hlc4nqfx0l06f6p7z7lmd77qcwszi7wc-coreutils-9.11/bin/sleep 999999999 && echo a83561e9-d2b9-440e-98b0-316915772144'29Running as unit: run-p481-i102941537.service; invocation ID: b50febd6ebd84765aec9fea6528d4d1730To attach to container machine run on the same machine that runs the test:31 sudo nsenter --user --target $(\pgrep -f '^/bin/sh.*a83561e9-d2b9-440e-98b0-316915772144') --mount --uts --ipc --net --pid --cgroup /bin/sh -c bash 3233To inject external network and continue test, run:34sudo /nix/store/d6kq2phq0zy5invmkfgg8h35zxaf13s9-python3-3.13.15/bin/python3.13 /nix/store/2y51rn5wgsfsam71nsisca336nva2cm8-test-driver-0.0.1/lib/python3.13/site-packages/test_driver/inject_network.py a83561e9-d2b9-440e-98b0-31691577214435+ systemctl --no-pager show matrix-synapse36+ 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+ nc -z -v ::1 800844Connection to ::1 8008 port [tcp/http-alt] succeeded!45machine: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'46+ curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'47(finished: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test', in 0.02 seconds)48+ systemctl restart matrix-synapse49+ journalctl -u matrix-synapse --no-pager50Aug 23 15:10:13 machine systemd[1]: Starting Synapse Matrix homeserver...51Aug 23 15:10:16 machine matrix-synapse-pre-start[476]: Generating signing key file /var/lib/matrix-synapse/homeserver.signing.key52Aug 23 15:10:19 machine synapse_homeserver[492]: This server is configured to use 'matrix.org' as its trusted key server via the53Aug 23 15:10:19 machine synapse_homeserver[492]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key54Aug 23 15:10:19 machine synapse_homeserver[492]: server since it is long-lived, stable and trusted. However, some admins may55Aug 23 15:10:19 machine synapse_homeserver[492]: wish to use another server for this purpose.56Aug 23 15:10:19 machine synapse_homeserver[492]: To suppress this warning and continue using 'matrix.org', admins should set57Aug 23 15:10:19 machine synapse_homeserver[492]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.58Aug 23 15:10:19 machine synapse_homeserver[492]: --------------------------------------------------------------------------------59Aug 23 15:10:19 machine synapse[492]: synapse.config.logger: [main] ***** STARTING SERVER *****60Aug 23 15:10:19 machine synapse[492]: synapse.config.logger: [main] Server /nix/store/1s8lqnc1k176xsjap48vxjq430ckjqnm-matrix-synapse-1.159.0/bin/synapse_homeserver version 1.159.061Aug 23 15:10:19 machine synapse[492]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc62Aug 23 15:10:19 machine synapse[492]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse63Aug 23 15:10:19 machine synapse[492]: synapse.config.logger: [main] Server hostname: clan.test64Aug 23 15:10:19 machine synapse[492]: synapse.config.logger: [main] Public Base URL: https://clan.test/65Aug 23 15:10:19 machine synapse[492]: synapse.config.logger: [main] Instance name: master66Aug 23 15:10:19 machine synapse[492]: synapse.config.logger: [main] Twisted reactor: EPollReactor67Aug 23 15:10:19 machine synapse[492]: synapse.app.homeserver: [main] Setting up server68Aug 23 15:10:19 machine synapse[492]: synapse.server: [main] Setting up.69Aug 23 15:10:19 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: Checking database server70Aug 23 15:10:19 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']71Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version72Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] ['main', 'state']: Initialising new database73Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v7374Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/01event_failed_pull_attempts.sql75Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/02add_pusher_enabled.sql76Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/02room_id_indexes_for_purging.sql77Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/03pusher_device_id.sql78Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/03users_approved_column.sql79Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/04partial_join_details.sql80Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/04pending_device_list_updates.sql81Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/05old_push_actions.sql.postgres82Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/06thread_notifications_thread_id_idx.sql83Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/08thread_receipts_non_null.sql.postgres84Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/09partial_joined_via_destination.sql85Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/09threads_table.sql86Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Running 73/10_update_sqlite_fts4_tokenizer.py:run_create87Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/10login_tokens.sql88Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/11event_search_room_id_n_distinct.sql.postgres89Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/12refactor_device_list_outbound_pokes.sql90Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/13add_device_lists_index.sql91Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/20_un_partial_stated_room_stream.sql92Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/21_un_partial_stated_room_stream_seq.sql.postgres93Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/22_rebuild_user_dir_stats.sql94Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/22_un_partial_stated_event_stream.sql95Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/23_fix_thread_index.sql96Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/23_un_partial_stated_room_stream_seq.sql.postgres97Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/24_events_jump_to_date_index.sql98Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/25drop_presence.sql99Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v74100Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/01_user_directory_stale_remote_users.sql101Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/02_set_device_id_for_pushers_bg_update.sql102Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/03_membership_tables_event_stream_ordering.sql.postgres103Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/03_room_membership_index.sql104Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/04_delete_e2e_backup_keys_for_deactivated_users.sql105Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Running 74/04_membership_tables_event_stream_ordering_triggers.py:run_create106Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/05_events_txn_id_device_id.sql107Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/90COMMENTS_destinations.sql.postgres108Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v75109Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v76110Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 76/01_add_profiles_full_user_id_column.sql111Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 76/02_add_user_filters_full_user_id_column.sql112Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 76/03_per_user_experimental_features.sql113Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 76/04_add_room_forgetter.sql114Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v77115Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/01_add_profiles_not_valid_check.sql.postgres116Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/02_add_user_filters_not_valid_check.sql.postgres117Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 77/03bg_populate_full_user_id_profiles.sql118Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 77/04bg_populate_full_user_id_user_filters.sql119Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 77/05thread_notifications_backfill.sql120Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions.sql.postgres121Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions_staging.sql.postgres122Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_summary.sql.postgres123Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 77/14bg_indices_event_stream_ordering.sql124Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v78125Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Running 78/03event_extremities_constraints.py:run_create126Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Running 78/04_add_full_user_id_index_user_filters.py:run_create127Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v79128Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/03_read_write_locks_triggers.sql.postgres129Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Running 79/04_mitigate_stream_ordering_update_race.py:run_create130Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/05_read_write_locks_triggers.sql.postgres131Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v80132Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 80/01_users_alter_locked.sql133Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/02_read_write_locks_unlogged.sql.postgres134Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 80/02_scheduled_tasks.sql135Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/03_read_write_locks_triggers.sql.postgres136Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/04_read_write_locks_deadlock.sql.postgres137Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v81138Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v82139Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 82/02_scheduled_tasks_index.sql140Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 82/04_add_indices_for_purging_rooms.sql141Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 82/05gaps.sql142Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v83143Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 83/01_drop_old_tables.sql144Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 83/05_cross_signing_key_update_grant.sql145Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 83/06_event_push_summary_room.sql146Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v84147Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/01_auth_links_stats.sql.postgres148Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 84/02_auth_links_index.sql149Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/03_auth_links_analyze.sql.postgres150Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 84/04_access_token_index.sql151Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v85152Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/01_add_suspended.sql153Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/02_add_instance_names.sql154Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 85/03_new_sequences.sql.postgres155Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/04_cleanup_device_federation_outbox.sql156Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/05_add_instance_names_converted_pos.sql157Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/06_add_room_reports.sql158Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v86159Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 86/01_authenticate_media.sql160Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 86/02_receipts_event_id_index.sql161Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v87162Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 87/01_sliding_sync_memberships.sql163Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 87/02_per_connection_state.sql164Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 87/03_current_state_index.sql165Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v88166Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/01_add_delayed_events.sql167Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/01_custom_profile_fields.sql168Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/02_fix_sliding_sync_membership_snapshots_forgotten_column.sql169Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/03_add_otk_ts_added_index.sql170Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/04_current_state_delta_index.sql171Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 88/05_drop_old_otks.sql.postgres172Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/05_sliding_sync_room_config_index.sql173Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/06_events_received_ts_index.sql174Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v89175Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 89/01_sliding_sync_membership_snapshot_index.sql176Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 89/01_state_groups_deletion.sql177Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v90178Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 90/01_add_column_participant_room_memberships_table.sql179Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 90/02_delete_unreferenced_state_groups.sql180Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 90/03_remove_old_deletion_bg_update.sql181Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v91182Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 91/01_media_hash.sql183Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v92184Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/01_remove_trigger.sql.postgres185Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/02_remove_populate_participant_bg_update.sql186Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/04_ss_membership_snapshot_idx.sql187Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/04_thread_subscriptions.sql188Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/04_thread_subscriptions_seq.sql.postgres189Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/05_fixup_max_depth_cap.sql190Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/05_thread_subscriptions_comments.sql.postgres191Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/06_device_federation_inbox_index.sql192Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/06_threads_last_sent_stream_ordering_comments.sql.postgres193Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/07_add_user_reports.sql194Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/07_event_txn_id_device_id_txn_id2.sql195Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/08_room_ban_redactions.sql196Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/08_thread_subscriptions_seq_fixup.sql.postgres197Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/09_thread_subscriptions_update.sql198Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/09_thread_subscriptions_update.sql.postgres199Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v93200Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 93/01_add_delayed_events.sql201Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 93/01_sticky_events.sql202Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 93/01_sticky_events_seq.sql.postgres203Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 93/02_sliding_sync_members.sql204Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 93/03_sss_pos_last_used.sql205Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Running 93/04_make_delayed_event_content_text.py:run_create206Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v94207Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/01_redactions_recheck.sql208Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/02_redactions_recheck_bg_update.sql209Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/03_device_lists_room_timestamp.sql210Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/03_quarantined_media_tracking.sql211Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/03_quarantined_media_tracking_seq.sql.postgres212Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/03_state_dag_fwd_extrems.sql213Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/04_device_lists_changes_max_pruned.sql214Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/05_rerun_flag_existing_quarantined_media.sql215Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/06_sliding_sync_connections_last_used_ts_index.sql216Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/07_profile_updates.sql217Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/07_profile_updates_seq.sql.postgres218Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/07_sliding_sync_lazy_members_position_index.sql219Aug 23 15:10:19 machine synapse[492]: synapse.storage.prepare_database: [main] Schema now up to date220Aug 23 15:10:19 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database221Aug 23 15:10:19 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1222Aug 23 15:10:19 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1223Aug 23 15:10:19 machine synapse[492]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago224Aug 23 15:10:19 machine synapse[492]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0225Aug 23 15:10:19 machine synapse[492]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago226Aug 23 15:10:19 machine synapse[492]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0227Aug 23 15:10:20 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 1228Aug 23 15:10:20 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1229Aug 23 15:10:20 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1230Aug 23 15:10:20 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1231Aug 23 15:10:20 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1232Aug 23 15:10:20 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database233Aug 23 15:10:20 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: prepared234Aug 23 15:10:20 machine synapse[492]: synapse.server: [main] Finished setting up.235Aug 23 15:10:20 machine synapse[492]: twisted: [main] Redirected stdout/stderr to logs236Aug 23 15:10:20 machine synapse[492]: synapse.app.homeserver: [main] Running237Aug 23 15:10:20 machine synapse[492]: synapse.app.homeserver: [main] Set file limit to: 524288238Aug 23 15:10:20 machine synapse[492]: synapse.push.pusher: [call_when_running] email enable notifs: False239Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'240Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'241Aug 23 15:10:20 machine synapse[492]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds242Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'243Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'244Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'245Aug 23 15:10:20 machine synapse[492]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter246Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'247Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'248Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'249Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'250Aug 23 15:10:20 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'251Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffee079120> to path b'/health'252Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffee303820> to path b'/_matrix/client'253Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffee309520> to path b'/.well-known'254Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffee3039a0> to path b'/_synapse/admin'255Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffee3099a0> to path b'/_synapse/client/pick_idp'256Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffe1a51f60> to path b'/_synapse/client/pick_username'257Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffee309fa0> to path b'/_synapse/client/new_user_consent'258Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffee30a120> to path b'/_synapse/client/sso_register'259Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffee30a2a0> to path b'/_synapse/client/unsubscribe'260Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.media_upload_limit_exceeded.MediaUploadLimitExceededResource object at 0xffffee30a420> to path b'/_synapse/client/media_upload_limit_exceeded'261Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/1s8lqnc1k176xsjap48vxjq430ckjqnm-matrix-synapse-1.159.0/lib/python3.13/site-packages/synapse/static') to path b'/_matrix/static'262Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee30a8a0> to path b'/_matrix/media/r0'263Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee30a8a0> to path b'/_matrix/media/v3'264Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee30a8a0> to path b'/_matrix/media/v1'265Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffee30b4a0> to path b'/_matrix/federation'266Aug 23 15:10:20 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffee30e620> to path b'/_matrix/key'267Aug 23 15:10:20 machine synapse[492]: twisted: [call_when_running] SynapseSite starting on 8008268Aug 23 15:10:20 machine synapse[492]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008269Aug 23 15:10:20 machine synapse[492]: 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).270Aug 23 15:10:20 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master271Aug 23 15:10:20 machine synapse[492]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping272Aug 23 15:10:20 machine synapse[492]: synapse.push.pusherpool: [start_pushers-0] Started pushers273Aug 23 15:10:20 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[521]: Connection to ::1 8008 port [tcp/http-alt] succeeded!274Aug 23 15:10:20 machine synapse[492]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.002sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]275Aug 23 15:10:21 machine synapse[492]: synapse.handlers.auth: [POST-1] Logging in user @admin:clan.test on device LXJCKZLBER276Aug 23 15:10:21 machine synapse[492]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.300sec/0.001sec ru=(0.254sec, 0.006sec) db=(0.005sec/0.031sec/12) 138B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]277Aug 23 15:10:21 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[522]: Sending registration request...278Aug 23 15:10:21 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[522]: Success!279Aug 23 15:10:21 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'threads_backfill'280Aug 23 15:10:21 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Running background update 'threads_backfill'. Processed 0 items in 6ms. (total_rate=None/ms, current_rate=None/ms, total_updated=0, batch_size=100)281Aug 23 15:10:21 machine synapse[492]: synapse.access.http.8008: [GET-2] ::1 - 8008 - {None} Processed request: 0.000sec/0.001sec ru=(0.000sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]282Aug 23 15:10:22 machine synapse[492]: synapse.handlers.auth: [POST-3] Logging in user @someuser:clan.test on device PJKQQJWMRD283Aug 23 15:10:22 machine synapse[492]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.301sec/0.001sec ru=(0.272sec, 0.001sec) db=(0.003sec/0.020sec/12) 145B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]284Aug 23 15:10:22 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[529]: Sending registration request...285Aug 23 15:10:22 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[529]: Success!286Aug 23 15:10:22 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'device_lists_changes_in_room_by_room_index'287Aug 23 15:10:22 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Adding index device_lists_changes_in_room_by_room_idx to device_lists_changes_in_room288Aug 23 15:10:22 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Running background update 'device_lists_changes_in_room_by_room_index'. Processed 1 items in 6ms. (total_rate=0.16666666666666666/ms, current_rate=0.16666666666666666/ms, total_updated=1, batch_size=100)289Aug 23 15:10:22 machine systemd[1]: Started Synapse Matrix homeserver.290Aug 23 15:10:22 machine synapse[492]: synapse.access.http.8008: [GET-4] ::1 - 8008 - {None} Processed request: 0.001sec/-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]291Aug 23 15:10:22 machine systemd[1]: Stopping Synapse Matrix homeserver...292Aug 23 15:10:22 machine synapse[492]: twisted: [sentinel] Received SIGTERM, shutting down.293Aug 23 15:10:22 machine synapse[492]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropping held locks due to shutdown294Aug 23 15:10:22 machine synapse[492]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropped locks due to shutdown295Aug 23 15:10:22 machine synapse[492]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Performing _on_shutdown. Persisting 0 unpersisted changes296Aug 23 15:10:22 machine synapse[492]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Finished _on_shutdown297Aug 23 15:10:22 machine synapse[492]: synapse.app._base: [log_shutdown] Shutting down...298Aug 23 15:10:22 machine synapse[492]: twisted: [sentinel] (TCP Port 8008 Closed)299Aug 23 15:10:22 machine synapse[492]: twisted: [sentinel] Main loop terminated.300Aug 23 15:10:22 machine systemd[1]: matrix-synapse.service: Deactivated successfully.301Aug 23 15:10:22 machine systemd[1]: Stopped Synapse Matrix homeserver.302Aug 23 15:10:22 machine systemd[1]: matrix-synapse.service: Consumed 8.405s CPU time over 9.094s wall clock time.303Aug 23 15:10:22 machine systemd[1]: Starting Synapse Matrix homeserver...304Aug 23 15:10:28 machine synapse_homeserver[560]: This server is configured to use 'matrix.org' as its trusted key server via the305Aug 23 15:10:28 machine synapse_homeserver[560]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key306Aug 23 15:10:28 machine synapse_homeserver[560]: server since it is long-lived, stable and trusted. However, some admins may307Aug 23 15:10:28 machine synapse_homeserver[560]: wish to use another server for this purpose.308Aug 23 15:10:28 machine synapse_homeserver[560]: To suppress this warning and continue using 'matrix.org', admins should set309Aug 23 15:10:28 machine synapse_homeserver[560]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.310Aug 23 15:10:28 machine synapse_homeserver[560]: --------------------------------------------------------------------------------311Aug 23 15:10:28 machine synapse[560]: synapse.config.logger: [main] ***** STARTING SERVER *****312Aug 23 15:10:28 machine synapse[560]: synapse.config.logger: [main] Server /nix/store/1s8lqnc1k176xsjap48vxjq430ckjqnm-matrix-synapse-1.159.0/bin/synapse_homeserver version 1.159.0313Aug 23 15:10:28 machine synapse[560]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc314Aug 23 15:10:28 machine synapse[560]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse315Aug 23 15:10:28 machine synapse[560]: synapse.config.logger: [main] Server hostname: clan.test316Aug 23 15:10:28 machine synapse[560]: synapse.config.logger: [main] Public Base URL: https://clan.test/317Aug 23 15:10:28 machine synapse[560]: synapse.config.logger: [main] Instance name: master318Aug 23 15:10:28 machine synapse[560]: synapse.config.logger: [main] Twisted reactor: EPollReactor319Aug 23 15:10:28 machine synapse[560]: synapse.app.homeserver: [main] Setting up server320Aug 23 15:10:28 machine synapse[560]: synapse.server: [main] Setting up.321Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: Checking database server322Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']323Aug 23 15:10:28 machine synapse[560]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version324Aug 23 15:10:28 machine synapse[560]: synapse.storage.prepare_database: [main] ['main', 'state']: Existing schema is 94 (+12 deltas)325Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases.main: [main] Checking database for consistency with configuration...326Aug 23 15:10:28 machine synapse[560]: synapse.storage.prepare_database: [main] Applying schema deltas for v94327Aug 23 15:10:28 machine synapse[560]: synapse.storage.prepare_database: [main] Schema now up to date328Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database329Aug 23 15:10:28 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1330Aug 23 15:10:28 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1331Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago332Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0333Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago334Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0335Aug 23 15:10:28 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 3336Aug 23 15:10:28 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1337Aug 23 15:10:28 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1338Aug 23 15:10:28 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1339Aug 23 15:10:28 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1340Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database341Aug 23 15:10:28 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: prepared342Aug 23 15:10:28 machine synapse[560]: synapse.server: [main] Finished setting up.343Aug 23 15:10:28 machine synapse[560]: twisted: [main] Redirected stdout/stderr to logs344Aug 23 15:10:28 machine synapse[560]: synapse.app.homeserver: [main] Running345Aug 23 15:10:28 machine synapse[560]: synapse.app.homeserver: [main] Set file limit to: 524288346Aug 23 15:10:28 machine synapse[560]: synapse.push.pusher: [call_when_running] email enable notifs: False347Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'348Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'349Aug 23 15:10:28 machine synapse[560]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds350Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'351Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'352Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'353Aug 23 15:10:28 machine synapse[560]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter354Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'355Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'356Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'357Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'358Aug 23 15:10:28 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'359Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffee0792a0> to path b'/health'360Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffee3039a0> to path b'/_matrix/client'361Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffee3096a0> to path b'/.well-known'362Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffee303b20> to path b'/_synapse/admin'363Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffee309b20> to path b'/_synapse/client/pick_idp'364Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffe1aa1e20> to path b'/_synapse/client/pick_username'365Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffee30a120> to path b'/_synapse/client/new_user_consent'366Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffee30a2a0> to path b'/_synapse/client/sso_register'367Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffee30a420> to path b'/_synapse/client/unsubscribe'368Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.media_upload_limit_exceeded.MediaUploadLimitExceededResource object at 0xffffee30a5a0> to path b'/_synapse/client/media_upload_limit_exceeded'369Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/1s8lqnc1k176xsjap48vxjq430ckjqnm-matrix-synapse-1.159.0/lib/python3.13/site-packages/synapse/static') to path b'/_matrix/static'370Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee30aa20> to path b'/_matrix/media/r0'371Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee30aa20> to path b'/_matrix/media/v3'372Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee30aa20> to path b'/_matrix/media/v1'373Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffee30b620> to path b'/_matrix/federation'374Aug 23 15:10:28 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffee30e7a0> to path b'/_matrix/key'375Aug 23 15:10:28 machine synapse[560]: twisted: [call_when_running] SynapseSite starting on 8008376Aug 23 15:10:28 machine synapse[560]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008377Aug 23 15:10:28 machine synapse[560]: 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).378Aug 23 15:10:28 machine synapse[560]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master379Aug 23 15:10:28 machine synapse[560]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping380Aug 23 15:10:28 machine synapse[560]: synapse.push.pusherpool: [start_pushers-0] Started pushers381Aug 23 15:10:28 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[585]: Connection to ::1 8008 port [tcp/http-alt] succeeded!382Aug 23 15:10:29 machine synapse[560]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.002sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]383Aug 23 15:10:29 machine synapse[560]: synapse.http.server: [POST-1] <XForwardedForRequest at 0xffffe1aa48a0 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.384Aug 23 15:10:29 machine synapse[560]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.249sec/0.001sec ru=(0.242sec, 0.000sec) db=(0.000sec/0.002sec/1) 60B 400 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]385Aug 23 15:10:29 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[586]: Sending registration request...386Aug 23 15:10:29 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[586]: User already exists. Skipping.387Aug 23 15:10:29 machine synapse[560]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'populate_stats_process_rooms'388Aug 23 15:10:29 machine synapse[560]: synapse.storage.background_updates: [background_updates-0] Running background update 'populate_stats_process_rooms'. Processed 1 items in 4ms. (total_rate=0.25/ms, current_rate=0.25/ms, total_updated=1, batch_size=100)389Aug 23 15:10:30 machine synapse[560]: synapse.access.http.8008: [GET-2] ::1 - 8008 - {None} Processed request: 0.000sec/0.001sec ru=(0.000sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]390Aug 23 15:10:30 machine synapse[560]: synapse.http.server: [POST-3] <XForwardedForRequest at 0xffffedc33960 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.391Aug 23 15:10:30 machine synapse[560]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.260sec/0.000sec ru=(0.256sec, 0.000sec) db=(0.000sec/0.001sec/1) 60B 400 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]392Aug 23 15:10:30 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[592]: Sending registration request...393Aug 23 15:10:30 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[592]: User already exists. Skipping.394Aug 23 15:10:30 machine systemd[1]: Started Synapse Matrix homeserver.395+ systemctl --no-pager show matrix-synapse396+ nc -z -v ::1 8008397Connection to ::1 8008 port [tcp/http-alt] succeeded!398+ curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'399