container-test-run-matrix-synapse
checks.aarch64-linux.matrix-synapse
· build #453
· raw
1additionally exposed symbols:2 machine,3 start_all, machines, driver, Machine, wait_for_signal4Starting machine567<<< NixOS Stage 2 >>>89booting system configuration /nix/store/l5c7rd4vxn2vkilx0swzbwjf6wivvcgd-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 d0c9cf53-5bd4-4631-b0f5-df3893bd1b7a'29Running as unit: run-p482-i100568579.service; invocation ID: 48846095b0c94c25b15f45228151f11330To attach to container machine run on the same machine that runs the test:31 sudo nsenter --user --target $(\pgrep -f '^/bin/sh.*d0c9cf53-5bd4-4631-b0f5-df3893bd1b7a') --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 d0c9cf53-5bd4-4631-b0f5-df3893bd1b7a35+ 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 21 20:29:12 machine systemd[1]: Starting Synapse Matrix homeserver...51Aug 21 20:29:15 machine matrix-synapse-pre-start[477]: Generating signing key file /var/lib/matrix-synapse/homeserver.signing.key52Aug 21 20:29:18 machine synapse_homeserver[493]: This server is configured to use 'matrix.org' as its trusted key server via the53Aug 21 20:29:18 machine synapse_homeserver[493]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key54Aug 21 20:29:18 machine synapse_homeserver[493]: server since it is long-lived, stable and trusted. However, some admins may55Aug 21 20:29:18 machine synapse_homeserver[493]: wish to use another server for this purpose.56Aug 21 20:29:18 machine synapse_homeserver[493]: To suppress this warning and continue using 'matrix.org', admins should set57Aug 21 20:29:18 machine synapse_homeserver[493]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.58Aug 21 20:29:18 machine synapse_homeserver[493]: --------------------------------------------------------------------------------59Aug 21 20:29:18 machine synapse[493]: synapse.config.logger: [main] ***** STARTING SERVER *****60Aug 21 20:29:18 machine synapse[493]: synapse.config.logger: [main] Server /nix/store/lb04knrjrz1zzn0cwdpx2k735s0j8adc-matrix-synapse-1.158.0/bin/synapse_homeserver version 1.158.061Aug 21 20:29:18 machine synapse[493]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc62Aug 21 20:29:18 machine synapse[493]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse63Aug 21 20:29:18 machine synapse[493]: synapse.config.logger: [main] Server hostname: clan.test64Aug 21 20:29:18 machine synapse[493]: synapse.config.logger: [main] Public Base URL: https://clan.test/65Aug 21 20:29:18 machine synapse[493]: synapse.config.logger: [main] Instance name: master66Aug 21 20:29:18 machine synapse[493]: synapse.config.logger: [main] Twisted reactor: EPollReactor67Aug 21 20:29:18 machine synapse[493]: synapse.app.homeserver: [main] Setting up server68Aug 21 20:29:18 machine synapse[493]: synapse.server: [main] Setting up.69Aug 21 20:29:18 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: Checking database server70Aug 21 20:29:18 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']71Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version72Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] ['main', 'state']: Initialising new database73Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v7374Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/01event_failed_pull_attempts.sql75Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/02add_pusher_enabled.sql76Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/02room_id_indexes_for_purging.sql77Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/03pusher_device_id.sql78Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/03users_approved_column.sql79Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/04partial_join_details.sql80Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/04pending_device_list_updates.sql81Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/05old_push_actions.sql.postgres82Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/06thread_notifications_thread_id_idx.sql83Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/08thread_receipts_non_null.sql.postgres84Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/09partial_joined_via_destination.sql85Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/09threads_table.sql86Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Running 73/10_update_sqlite_fts4_tokenizer.py:run_create87Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/10login_tokens.sql88Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/11event_search_room_id_n_distinct.sql.postgres89Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/12refactor_device_list_outbound_pokes.sql90Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/13add_device_lists_index.sql91Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/20_un_partial_stated_room_stream.sql92Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/21_un_partial_stated_room_stream_seq.sql.postgres93Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/22_rebuild_user_dir_stats.sql94Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/22_un_partial_stated_event_stream.sql95Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/23_fix_thread_index.sql96Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/23_un_partial_stated_room_stream_seq.sql.postgres97Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/24_events_jump_to_date_index.sql98Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/25drop_presence.sql99Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v74100Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/01_user_directory_stale_remote_users.sql101Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/02_set_device_id_for_pushers_bg_update.sql102Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/03_membership_tables_event_stream_ordering.sql.postgres103Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/03_room_membership_index.sql104Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/04_delete_e2e_backup_keys_for_deactivated_users.sql105Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Running 74/04_membership_tables_event_stream_ordering_triggers.py:run_create106Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/05_events_txn_id_device_id.sql107Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/90COMMENTS_destinations.sql.postgres108Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v75109Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v76110Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 76/01_add_profiles_full_user_id_column.sql111Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 76/02_add_user_filters_full_user_id_column.sql112Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 76/03_per_user_experimental_features.sql113Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 76/04_add_room_forgetter.sql114Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v77115Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/01_add_profiles_not_valid_check.sql.postgres116Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/02_add_user_filters_not_valid_check.sql.postgres117Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 77/03bg_populate_full_user_id_profiles.sql118Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 77/04bg_populate_full_user_id_user_filters.sql119Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 77/05thread_notifications_backfill.sql120Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions.sql.postgres121Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions_staging.sql.postgres122Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_summary.sql.postgres123Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 77/14bg_indices_event_stream_ordering.sql124Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v78125Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Running 78/03event_extremities_constraints.py:run_create126Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Running 78/04_add_full_user_id_index_user_filters.py:run_create127Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v79128Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/03_read_write_locks_triggers.sql.postgres129Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Running 79/04_mitigate_stream_ordering_update_race.py:run_create130Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/05_read_write_locks_triggers.sql.postgres131Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v80132Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 80/01_users_alter_locked.sql133Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/02_read_write_locks_unlogged.sql.postgres134Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 80/02_scheduled_tasks.sql135Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/03_read_write_locks_triggers.sql.postgres136Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/04_read_write_locks_deadlock.sql.postgres137Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v81138Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v82139Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 82/02_scheduled_tasks_index.sql140Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 82/04_add_indices_for_purging_rooms.sql141Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 82/05gaps.sql142Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v83143Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 83/01_drop_old_tables.sql144Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 83/05_cross_signing_key_update_grant.sql145Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 83/06_event_push_summary_room.sql146Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v84147Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/01_auth_links_stats.sql.postgres148Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 84/02_auth_links_index.sql149Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/03_auth_links_analyze.sql.postgres150Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 84/04_access_token_index.sql151Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v85152Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/01_add_suspended.sql153Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/02_add_instance_names.sql154Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 85/03_new_sequences.sql.postgres155Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/04_cleanup_device_federation_outbox.sql156Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/05_add_instance_names_converted_pos.sql157Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/06_add_room_reports.sql158Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v86159Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 86/01_authenticate_media.sql160Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 86/02_receipts_event_id_index.sql161Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v87162Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 87/01_sliding_sync_memberships.sql163Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 87/02_per_connection_state.sql164Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 87/03_current_state_index.sql165Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v88166Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/01_add_delayed_events.sql167Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/01_custom_profile_fields.sql168Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/02_fix_sliding_sync_membership_snapshots_forgotten_column.sql169Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/03_add_otk_ts_added_index.sql170Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/04_current_state_delta_index.sql171Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 88/05_drop_old_otks.sql.postgres172Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/05_sliding_sync_room_config_index.sql173Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/06_events_received_ts_index.sql174Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v89175Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 89/01_sliding_sync_membership_snapshot_index.sql176Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 89/01_state_groups_deletion.sql177Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v90178Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 90/01_add_column_participant_room_memberships_table.sql179Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 90/02_delete_unreferenced_state_groups.sql180Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 90/03_remove_old_deletion_bg_update.sql181Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v91182Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 91/01_media_hash.sql183Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v92184Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/01_remove_trigger.sql.postgres185Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/02_remove_populate_participant_bg_update.sql186Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/04_ss_membership_snapshot_idx.sql187Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/04_thread_subscriptions.sql188Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/04_thread_subscriptions_seq.sql.postgres189Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/05_fixup_max_depth_cap.sql190Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/05_thread_subscriptions_comments.sql.postgres191Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/06_device_federation_inbox_index.sql192Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/06_threads_last_sent_stream_ordering_comments.sql.postgres193Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/07_add_user_reports.sql194Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/07_event_txn_id_device_id_txn_id2.sql195Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/08_room_ban_redactions.sql196Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/08_thread_subscriptions_seq_fixup.sql.postgres197Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/09_thread_subscriptions_update.sql198Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/09_thread_subscriptions_update.sql.postgres199Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v93200Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 93/01_add_delayed_events.sql201Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 93/01_sticky_events.sql202Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 93/01_sticky_events_seq.sql.postgres203Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 93/02_sliding_sync_members.sql204Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 93/03_sss_pos_last_used.sql205Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Running 93/04_make_delayed_event_content_text.py:run_create206Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v94207Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/01_redactions_recheck.sql208Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/02_redactions_recheck_bg_update.sql209Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/03_device_lists_room_timestamp.sql210Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/03_quarantined_media_tracking.sql211Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/03_quarantined_media_tracking_seq.sql.postgres212Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/03_state_dag_fwd_extrems.sql213Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/04_device_lists_changes_max_pruned.sql214Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/05_rerun_flag_existing_quarantined_media.sql215Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/06_sliding_sync_connections_last_used_ts_index.sql216Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/07_sliding_sync_lazy_members_position_index.sql217Aug 21 20:29:18 machine synapse[493]: synapse.storage.prepare_database: [main] Schema now up to date218Aug 21 20:29:18 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database219Aug 21 20:29:18 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1220Aug 21 20:29:18 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1221Aug 21 20:29:18 machine synapse[493]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago222Aug 21 20:29:18 machine synapse[493]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0223Aug 21 20:29:18 machine synapse[493]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago224Aug 21 20:29:18 machine synapse[493]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0225Aug 21 20:29:18 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 1226Aug 21 20:29:18 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1227Aug 21 20:29:18 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1228Aug 21 20:29:18 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1229Aug 21 20:29:18 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1230Aug 21 20:29:18 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database231Aug 21 20:29:18 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: prepared232Aug 21 20:29:18 machine synapse[493]: synapse.server: [main] Finished setting up.233Aug 21 20:29:18 machine synapse[493]: twisted: [main] Redirected stdout/stderr to logs234Aug 21 20:29:18 machine synapse[493]: synapse.app.homeserver: [main] Running235Aug 21 20:29:18 machine synapse[493]: synapse.app.homeserver: [main] Set file limit to: 524288236Aug 21 20:29:18 machine synapse[493]: synapse.push.pusher: [call_when_running] email enable notifs: False237Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'238Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'239Aug 21 20:29:18 machine synapse[493]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds240Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'241Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'242Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'243Aug 21 20:29:18 machine synapse[493]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter244Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'245Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'246Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'247Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'248Aug 21 20:29:18 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'249Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffee089ea0> to path b'/health'250Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffee2e2f20> to path b'/_matrix/client'251Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffee2e8c20> to path b'/.well-known'252Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffee2e30a0> to path b'/_synapse/admin'253Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffee2e90a0> to path b'/_synapse/client/pick_idp'254Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffedc5f8a0> to path b'/_synapse/client/pick_username'255Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffee2e96a0> to path b'/_synapse/client/new_user_consent'256Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffee2e9820> to path b'/_synapse/client/sso_register'257Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffee2e99a0> to path b'/_synapse/client/unsubscribe'258Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.media_upload_limit_exceeded.MediaUploadLimitExceededResource object at 0xffffee2e9b20> to path b'/_synapse/client/media_upload_limit_exceeded'259Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/lb04knrjrz1zzn0cwdpx2k735s0j8adc-matrix-synapse-1.158.0/lib/python3.13/site-packages/synapse/static') to path b'/_matrix/static'260Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee2e9fa0> to path b'/_matrix/media/r0'261Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee2e9fa0> to path b'/_matrix/media/v3'262Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee2e9fa0> to path b'/_matrix/media/v1'263Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffee2eaba0> to path b'/_matrix/federation'264Aug 21 20:29:18 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffee2edd20> to path b'/_matrix/key'265Aug 21 20:29:18 machine synapse[493]: twisted: [call_when_running] SynapseSite starting on 8008266Aug 21 20:29:18 machine synapse[493]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008267Aug 21 20:29:18 machine synapse[493]: 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).268Aug 21 20:29:18 machine synapse[493]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master269Aug 21 20:29:18 machine synapse[493]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping270Aug 21 20:29:18 machine synapse[493]: synapse.push.pusherpool: [start_pushers-0] Started pushers271Aug 21 20:29:19 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[521]: Connection to ::1 8008 port [tcp/http-alt] succeeded!272Aug 21 20:29:19 machine synapse[493]: 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.33.1" [0 dbevts]273Aug 21 20:29:19 machine synapse[493]: synapse.handlers.auth: [POST-1] Logging in user @admin:clan.test on device CCUCIBFXCE274Aug 21 20:29:19 machine synapse[493]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.304sec/0.001sec ru=(0.246sec, 0.010sec) db=(0.005sec/0.030sec/12) 138B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]275Aug 21 20:29:19 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[522]: Sending registration request...276Aug 21 20:29:19 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[522]: Success!277Aug 21 20:29:19 machine synapse[493]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'threads_backfill'278Aug 21 20:29:20 machine synapse[493]: synapse.storage.background_updates: [background_updates-0] Running background update 'threads_backfill'. Processed 0 items in 4ms. (total_rate=None/ms, current_rate=None/ms, total_updated=0, batch_size=100)279Aug 21 20:29:20 machine synapse[493]: 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]280Aug 21 20:29:20 machine synapse[493]: synapse.handlers.auth: [POST-3] Logging in user @someuser:clan.test on device NOYYTXNEWQ281Aug 21 20:29:20 machine synapse[493]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.303sec/0.001sec ru=(0.229sec, 0.020sec) db=(0.004sec/0.018sec/12) 145B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]282Aug 21 20:29:20 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[529]: Sending registration request...283Aug 21 20:29:20 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[529]: Success!284Aug 21 20:29:20 machine systemd[1]: Started Synapse Matrix homeserver.285Aug 21 20:29:21 machine synapse[493]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'device_lists_changes_in_room_by_room_index'286Aug 21 20:29:21 machine synapse[493]: synapse.storage.background_updates: [background_updates-0] Adding index device_lists_changes_in_room_by_room_idx to device_lists_changes_in_room287Aug 21 20:29:21 machine synapse[493]: synapse.storage.background_updates: [background_updates-0] Running background update 'device_lists_changes_in_room_by_room_index'. Processed 1 items in 7ms. (total_rate=0.14285714285714285/ms, current_rate=0.14285714285714285/ms, total_updated=1, batch_size=100)288Aug 21 20:29:21 machine synapse[493]: synapse.access.http.8008: [GET-4] ::1 - 8008 - {None} Processed request: 0.001sec/-0.000sec ru=(0.000sec, 0.001sec) db=(0.000sec/0.000sec/0) 10145B 200 "GET /_matrix/static/ HTTP/1.1" "curl/8.21.0" [0 dbevts]289Aug 21 20:29:21 machine synapse[493]: twisted: [sentinel] Received SIGTERM, shutting down.290Aug 21 20:29:21 machine systemd[1]: Stopping Synapse Matrix homeserver...291Aug 21 20:29:21 machine synapse[493]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropping held locks due to shutdown292Aug 21 20:29:21 machine synapse[493]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropped locks due to shutdown293Aug 21 20:29:21 machine synapse[493]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Performing _on_shutdown. Persisting 0 unpersisted changes294Aug 21 20:29:21 machine synapse[493]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Finished _on_shutdown295Aug 21 20:29:21 machine synapse[493]: synapse.app._base: [log_shutdown] Shutting down...296Aug 21 20:29:21 machine synapse[493]: twisted: [sentinel] (TCP Port 8008 Closed)297Aug 21 20:29:21 machine synapse[493]: twisted: [sentinel] Main loop terminated.298Aug 21 20:29:21 machine systemd[1]: matrix-synapse.service: Deactivated successfully.299Aug 21 20:29:21 machine systemd[1]: Stopped Synapse Matrix homeserver.300Aug 21 20:29:21 machine systemd[1]: matrix-synapse.service: Consumed 8.029s CPU time over 9.062s wall clock time.301Aug 21 20:29:21 machine systemd[1]: Starting Synapse Matrix homeserver...302Aug 21 20:29:27 machine synapse_homeserver[561]: This server is configured to use 'matrix.org' as its trusted key server via the303Aug 21 20:29:27 machine synapse_homeserver[561]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key304Aug 21 20:29:27 machine synapse_homeserver[561]: server since it is long-lived, stable and trusted. However, some admins may305Aug 21 20:29:27 machine synapse_homeserver[561]: wish to use another server for this purpose.306Aug 21 20:29:27 machine synapse_homeserver[561]: To suppress this warning and continue using 'matrix.org', admins should set307Aug 21 20:29:27 machine synapse_homeserver[561]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.308Aug 21 20:29:27 machine synapse_homeserver[561]: --------------------------------------------------------------------------------309Aug 21 20:29:27 machine synapse[561]: synapse.config.logger: [main] ***** STARTING SERVER *****310Aug 21 20:29:27 machine synapse[561]: synapse.config.logger: [main] Server /nix/store/lb04knrjrz1zzn0cwdpx2k735s0j8adc-matrix-synapse-1.158.0/bin/synapse_homeserver version 1.158.0311Aug 21 20:29:27 machine synapse[561]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc312Aug 21 20:29:27 machine synapse[561]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse313Aug 21 20:29:27 machine synapse[561]: synapse.config.logger: [main] Server hostname: clan.test314Aug 21 20:29:27 machine synapse[561]: synapse.config.logger: [main] Public Base URL: https://clan.test/315Aug 21 20:29:27 machine synapse[561]: synapse.config.logger: [main] Instance name: master316Aug 21 20:29:27 machine synapse[561]: synapse.config.logger: [main] Twisted reactor: EPollReactor317Aug 21 20:29:27 machine synapse[561]: synapse.app.homeserver: [main] Setting up server318Aug 21 20:29:27 machine synapse[561]: synapse.server: [main] Setting up.319Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: Checking database server320Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']321Aug 21 20:29:27 machine synapse[561]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version322Aug 21 20:29:27 machine synapse[561]: synapse.storage.prepare_database: [main] ['main', 'state']: Existing schema is 94 (+10 deltas)323Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases.main: [main] Checking database for consistency with configuration...324Aug 21 20:29:27 machine synapse[561]: synapse.storage.prepare_database: [main] Applying schema deltas for v94325Aug 21 20:29:27 machine synapse[561]: synapse.storage.prepare_database: [main] Schema now up to date326Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database327Aug 21 20:29:27 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1328Aug 21 20:29:27 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1329Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago330Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0331Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago332Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0333Aug 21 20:29:27 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 3334Aug 21 20:29:27 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1335Aug 21 20:29:27 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1336Aug 21 20:29:27 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1337Aug 21 20:29:27 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1338Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database339Aug 21 20:29:27 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: prepared340Aug 21 20:29:27 machine synapse[561]: synapse.server: [main] Finished setting up.341Aug 21 20:29:27 machine synapse[561]: twisted: [main] Redirected stdout/stderr to logs342Aug 21 20:29:27 machine synapse[561]: synapse.app.homeserver: [main] Running343Aug 21 20:29:27 machine synapse[561]: synapse.app.homeserver: [main] Set file limit to: 524288344Aug 21 20:29:27 machine synapse[561]: synapse.push.pusher: [call_when_running] email enable notifs: False345Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'346Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'347Aug 21 20:29:27 machine synapse[561]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds348Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'349Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'350Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'351Aug 21 20:29:27 machine synapse[561]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter352Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'353Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'354Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'355Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'356Aug 21 20:29:27 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'357Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffee06a020> to path b'/health'358Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffee3130a0> to path b'/_matrix/client'359Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffee318da0> to path b'/.well-known'360Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffee313220> to path b'/_synapse/admin'361Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffee319220> to path b'/_synapse/client/pick_idp'362Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffedcaf760> to path b'/_synapse/client/pick_username'363Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffee319820> to path b'/_synapse/client/new_user_consent'364Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffee3199a0> to path b'/_synapse/client/sso_register'365Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffee319b20> to path b'/_synapse/client/unsubscribe'366Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.media_upload_limit_exceeded.MediaUploadLimitExceededResource object at 0xffffee319ca0> to path b'/_synapse/client/media_upload_limit_exceeded'367Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/lb04knrjrz1zzn0cwdpx2k735s0j8adc-matrix-synapse-1.158.0/lib/python3.13/site-packages/synapse/static') to path b'/_matrix/static'368Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee31a120> to path b'/_matrix/media/r0'369Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee31a120> to path b'/_matrix/media/v3'370Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee31a120> to path b'/_matrix/media/v1'371Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffee31ad20> to path b'/_matrix/federation'372Aug 21 20:29:27 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffee31dea0> to path b'/_matrix/key'373Aug 21 20:29:27 machine synapse[561]: twisted: [call_when_running] SynapseSite starting on 8008374Aug 21 20:29:27 machine synapse[561]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008375Aug 21 20:29:27 machine synapse[561]: 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).376Aug 21 20:29:27 machine synapse[561]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master377Aug 21 20:29:27 machine synapse[561]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping378Aug 21 20:29:27 machine synapse[561]: synapse.push.pusherpool: [start_pushers-0] Started pushers379Aug 21 20:29:27 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[586]: Connection to ::1 8008 port [tcp/http-alt] succeeded!380Aug 21 20:29:28 machine synapse[561]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.003sec, 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]381Aug 21 20:29:28 machine synapse[561]: synapse.http.server: [POST-1] <XForwardedForRequest at 0xffffe16521e0 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.382Aug 21 20:29:28 machine synapse[561]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.253sec/0.000sec ru=(0.235sec, 0.007sec) db=(0.000sec/0.001sec/1) 60B 400 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]383Aug 21 20:29:28 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[587]: Sending registration request...384Aug 21 20:29:28 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[587]: User already exists. Skipping.385Aug 21 20:29:28 machine synapse[561]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'populate_stats_process_rooms'386Aug 21 20:29:28 machine synapse[561]: 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)387Aug 21 20:29:29 machine synapse[561]: 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.33.1" [0 dbevts]388Aug 21 20:29:29 machine synapse[561]: synapse.http.server: [POST-3] <XForwardedForRequest at 0xffffedca0ee0 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.389Aug 21 20:29:29 machine synapse[561]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.237sec/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.33.1" [0 dbevts]390Aug 21 20:29:29 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[593]: Sending registration request...391Aug 21 20:29:29 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[593]: User already exists. Skipping.392Aug 21 20:29:29 machine systemd[1]: Started Synapse Matrix homeserver.393+ systemctl --no-pager show matrix-synapse394+ nc -z -v ::1 8008395Connection to ::1 8008 port [tcp/http-alt] succeeded!396+ curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'397