container-test-run-matrix-synapse
checks.aarch64-linux.matrix-synapse
· build #532
· raw
1additionally exposed symbols:2 machine,3 start_all, machines, driver, Machine, wait_for_signal4Starting machine567<<< NixOS Stage 2 >>>89booting system configuration /nix/store/gnmf6gkx823qy0byqrbnsay716ya7gih-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 d167af57-d2c9-454d-aabc-cf236f7b3de3'29Running as unit: run-p474-i112860542.service; invocation ID: 0116f19756ef4312b777255470511ffe30To attach to container machine run on the same machine that runs the test:31 sudo nsenter --user --target $(\pgrep -f '^/bin/sh.*d167af57-d2c9-454d-aabc-cf236f7b3de3') --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/f4nvkcws5x7zcpbn7zsscrdviq2jxrpi-test-driver-0.0.1/lib/python3.13/site-packages/test_driver/inject_network.py d167af57-d2c9-454d-aabc-cf236f7b3de335+ 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+ systemctl --no-pager show matrix-synapse44+ nc -z -v ::1 800845Connection to ::1 8008 port [tcp/http-alt] succeeded!46machine: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'47+ curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'48(finished: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test', in 0.02 seconds)49+ systemctl restart matrix-synapse50+ journalctl -u matrix-synapse --no-pager51Aug 30 15:09:56 machine systemd[1]: Starting Synapse Matrix homeserver...52Aug 30 15:10:00 machine matrix-synapse-pre-start[479]: Generating signing key file /var/lib/matrix-synapse/homeserver.signing.key53Aug 30 15:10:03 machine synapse_homeserver[492]: This server is configured to use 'matrix.org' as its trusted key server via the54Aug 30 15:10:03 machine synapse_homeserver[492]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key55Aug 30 15:10:03 machine synapse_homeserver[492]: server since it is long-lived, stable and trusted. However, some admins may56Aug 30 15:10:03 machine synapse_homeserver[492]: wish to use another server for this purpose.57Aug 30 15:10:03 machine synapse_homeserver[492]: To suppress this warning and continue using 'matrix.org', admins should set58Aug 30 15:10:03 machine synapse_homeserver[492]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.59Aug 30 15:10:03 machine synapse_homeserver[492]: --------------------------------------------------------------------------------60Aug 30 15:10:03 machine synapse[492]: synapse.config.logger: [main] ***** STARTING SERVER *****61Aug 30 15:10:03 machine synapse[492]: synapse.config.logger: [main] Server /nix/store/1s8lqnc1k176xsjap48vxjq430ckjqnm-matrix-synapse-1.159.0/bin/synapse_homeserver version 1.159.062Aug 30 15:10:03 machine synapse[492]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc63Aug 30 15:10:03 machine synapse[492]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse64Aug 30 15:10:03 machine synapse[492]: synapse.config.logger: [main] Server hostname: clan.test65Aug 30 15:10:03 machine synapse[492]: synapse.config.logger: [main] Public Base URL: https://clan.test/66Aug 30 15:10:03 machine synapse[492]: synapse.config.logger: [main] Instance name: master67Aug 30 15:10:03 machine synapse[492]: synapse.config.logger: [main] Twisted reactor: EPollReactor68Aug 30 15:10:03 machine synapse[492]: synapse.app.homeserver: [main] Setting up server69Aug 30 15:10:03 machine synapse[492]: synapse.server: [main] Setting up.70Aug 30 15:10:03 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: Checking database server71Aug 30 15:10:03 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']72Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version73Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] ['main', 'state']: Initialising new database74Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v7375Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/01event_failed_pull_attempts.sql76Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/02add_pusher_enabled.sql77Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/02room_id_indexes_for_purging.sql78Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/03pusher_device_id.sql79Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/03users_approved_column.sql80Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/04partial_join_details.sql81Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/04pending_device_list_updates.sql82Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/05old_push_actions.sql.postgres83Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/06thread_notifications_thread_id_idx.sql84Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/08thread_receipts_non_null.sql.postgres85Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/09partial_joined_via_destination.sql86Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/09threads_table.sql87Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Running 73/10_update_sqlite_fts4_tokenizer.py:run_create88Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/10login_tokens.sql89Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/11event_search_room_id_n_distinct.sql.postgres90Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/12refactor_device_list_outbound_pokes.sql91Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/13add_device_lists_index.sql92Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/20_un_partial_stated_room_stream.sql93Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/21_un_partial_stated_room_stream_seq.sql.postgres94Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/22_rebuild_user_dir_stats.sql95Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/22_un_partial_stated_event_stream.sql96Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/23_fix_thread_index.sql97Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/23_un_partial_stated_room_stream_seq.sql.postgres98Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/24_events_jump_to_date_index.sql99Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 73/25drop_presence.sql100Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v74101Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/01_user_directory_stale_remote_users.sql102Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/02_set_device_id_for_pushers_bg_update.sql103Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/03_membership_tables_event_stream_ordering.sql.postgres104Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/03_room_membership_index.sql105Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/04_delete_e2e_backup_keys_for_deactivated_users.sql106Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Running 74/04_membership_tables_event_stream_ordering_triggers.py:run_create107Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 74/05_events_txn_id_device_id.sql108Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/90COMMENTS_destinations.sql.postgres109Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v75110Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v76111Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 76/01_add_profiles_full_user_id_column.sql112Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 76/02_add_user_filters_full_user_id_column.sql113Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 76/03_per_user_experimental_features.sql114Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 76/04_add_room_forgetter.sql115Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v77116Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/01_add_profiles_not_valid_check.sql.postgres117Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/02_add_user_filters_not_valid_check.sql.postgres118Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 77/03bg_populate_full_user_id_profiles.sql119Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 77/04bg_populate_full_user_id_user_filters.sql120Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 77/05thread_notifications_backfill.sql121Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions.sql.postgres122Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions_staging.sql.postgres123Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_summary.sql.postgres124Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 77/14bg_indices_event_stream_ordering.sql125Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v78126Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Running 78/03event_extremities_constraints.py:run_create127Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Running 78/04_add_full_user_id_index_user_filters.py:run_create128Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v79129Aug 30 15:10:03 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/03_read_write_locks_triggers.sql.postgres130Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Running 79/04_mitigate_stream_ordering_update_race.py:run_create131Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/05_read_write_locks_triggers.sql.postgres132Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v80133Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 80/01_users_alter_locked.sql134Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/02_read_write_locks_unlogged.sql.postgres135Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 80/02_scheduled_tasks.sql136Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/03_read_write_locks_triggers.sql.postgres137Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/04_read_write_locks_deadlock.sql.postgres138Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v81139Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v82140Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 82/02_scheduled_tasks_index.sql141Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 82/04_add_indices_for_purging_rooms.sql142Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 82/05gaps.sql143Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v83144Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 83/01_drop_old_tables.sql145Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 83/05_cross_signing_key_update_grant.sql146Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 83/06_event_push_summary_room.sql147Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v84148Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/01_auth_links_stats.sql.postgres149Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 84/02_auth_links_index.sql150Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/03_auth_links_analyze.sql.postgres151Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 84/04_access_token_index.sql152Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v85153Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/01_add_suspended.sql154Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/02_add_instance_names.sql155Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 85/03_new_sequences.sql.postgres156Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/04_cleanup_device_federation_outbox.sql157Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/05_add_instance_names_converted_pos.sql158Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 85/06_add_room_reports.sql159Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v86160Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 86/01_authenticate_media.sql161Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 86/02_receipts_event_id_index.sql162Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v87163Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 87/01_sliding_sync_memberships.sql164Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 87/02_per_connection_state.sql165Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 87/03_current_state_index.sql166Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v88167Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/01_add_delayed_events.sql168Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/01_custom_profile_fields.sql169Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/02_fix_sliding_sync_membership_snapshots_forgotten_column.sql170Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/03_add_otk_ts_added_index.sql171Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/04_current_state_delta_index.sql172Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 88/05_drop_old_otks.sql.postgres173Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/05_sliding_sync_room_config_index.sql174Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 88/06_events_received_ts_index.sql175Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v89176Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 89/01_sliding_sync_membership_snapshot_index.sql177Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 89/01_state_groups_deletion.sql178Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v90179Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 90/01_add_column_participant_room_memberships_table.sql180Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 90/02_delete_unreferenced_state_groups.sql181Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 90/03_remove_old_deletion_bg_update.sql182Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v91183Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 91/01_media_hash.sql184Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v92185Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/01_remove_trigger.sql.postgres186Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/02_remove_populate_participant_bg_update.sql187Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/04_ss_membership_snapshot_idx.sql188Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/04_thread_subscriptions.sql189Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/04_thread_subscriptions_seq.sql.postgres190Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/05_fixup_max_depth_cap.sql191Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/05_thread_subscriptions_comments.sql.postgres192Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/06_device_federation_inbox_index.sql193Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/06_threads_last_sent_stream_ordering_comments.sql.postgres194Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/07_add_user_reports.sql195Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/07_event_txn_id_device_id_txn_id2.sql196Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/08_room_ban_redactions.sql197Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/08_thread_subscriptions_seq_fixup.sql.postgres198Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 92/09_thread_subscriptions_update.sql199Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/09_thread_subscriptions_update.sql.postgres200Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v93201Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 93/01_add_delayed_events.sql202Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 93/01_sticky_events.sql203Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 93/01_sticky_events_seq.sql.postgres204Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 93/02_sliding_sync_members.sql205Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 93/03_sss_pos_last_used.sql206Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Running 93/04_make_delayed_event_content_text.py:run_create207Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema deltas for v94208Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/01_redactions_recheck.sql209Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/02_redactions_recheck_bg_update.sql210Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/03_device_lists_room_timestamp.sql211Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/03_quarantined_media_tracking.sql212Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/03_quarantined_media_tracking_seq.sql.postgres213Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/03_state_dag_fwd_extrems.sql214Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/04_device_lists_changes_max_pruned.sql215Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/05_rerun_flag_existing_quarantined_media.sql216Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/06_sliding_sync_connections_last_used_ts_index.sql217Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/07_profile_updates.sql218Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/07_profile_updates_seq.sql.postgres219Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Applying schema 94/07_sliding_sync_lazy_members_position_index.sql220Aug 30 15:10:04 machine synapse[492]: synapse.storage.prepare_database: [main] Schema now up to date221Aug 30 15:10:04 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database222Aug 30 15:10:04 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1223Aug 30 15:10:04 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1224Aug 30 15:10:04 machine synapse[492]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago225Aug 30 15:10:04 machine synapse[492]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0226Aug 30 15:10:04 machine synapse[492]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago227Aug 30 15:10:04 machine synapse[492]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0228Aug 30 15:10:04 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 1229Aug 30 15:10:04 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1230Aug 30 15:10:04 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1231Aug 30 15:10:04 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1232Aug 30 15:10:04 machine synapse[492]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1233Aug 30 15:10:04 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database234Aug 30 15:10:04 machine synapse[492]: synapse.storage.databases: [main] [database config 'master']: prepared235Aug 30 15:10:04 machine synapse[492]: synapse.server: [main] Finished setting up.236Aug 30 15:10:04 machine synapse[492]: twisted: [main] Redirected stdout/stderr to logs237Aug 30 15:10:04 machine synapse[492]: synapse.app.homeserver: [main] Running238Aug 30 15:10:04 machine synapse[492]: synapse.app.homeserver: [main] Set file limit to: 524288239Aug 30 15:10:04 machine synapse[492]: synapse.push.pusher: [call_when_running] email enable notifs: False240Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'241Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'242Aug 30 15:10:04 machine synapse[492]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds243Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'244Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'245Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'246Aug 30 15:10:04 machine synapse[492]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter247Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'248Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'249Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'250Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'251Aug 30 15:10:04 machine synapse[492]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'252Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffee0376a0> to path b'/health'253Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffee2f3820> to path b'/_matrix/client'254Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffee2f9520> to path b'/.well-known'255Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffee2f39a0> to path b'/_synapse/admin'256Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffee2f99a0> to path b'/_synapse/client/pick_idp'257Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffe1a51f60> to path b'/_synapse/client/pick_username'258Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffee2f9fa0> to path b'/_synapse/client/new_user_consent'259Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffee2fa120> to path b'/_synapse/client/sso_register'260Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffee2fa2a0> to path b'/_synapse/client/unsubscribe'261Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.media_upload_limit_exceeded.MediaUploadLimitExceededResource object at 0xffffee2fa420> to path b'/_synapse/client/media_upload_limit_exceeded'262Aug 30 15:10:04 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'263Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee2fa8a0> to path b'/_matrix/media/r0'264Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee2fa8a0> to path b'/_matrix/media/v3'265Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee2fa8a0> to path b'/_matrix/media/v1'266Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffee2fb4a0> to path b'/_matrix/federation'267Aug 30 15:10:04 machine synapse[492]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffee2fe620> to path b'/_matrix/key'268Aug 30 15:10:04 machine synapse[492]: twisted: [call_when_running] SynapseSite starting on 8008269Aug 30 15:10:04 machine synapse[492]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008270Aug 30 15:10:04 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).271Aug 30 15:10:04 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master272Aug 30 15:10:04 machine synapse[492]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping273Aug 30 15:10:04 machine synapse[492]: synapse.push.pusherpool: [start_pushers-0] Started pushers274Aug 30 15:10:04 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[521]: Connection to ::1 8008 port [tcp/http-alt] succeeded!275Aug 30 15:10:05 machine synapse[492]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.000sec, 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]276Aug 30 15:10:05 machine synapse[492]: synapse.handlers.auth: [POST-1] Logging in user @admin:clan.test on device SPSQKBHPCS277Aug 30 15:10:05 machine synapse[492]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.301sec/0.001sec ru=(0.263sec, 0.000sec) db=(0.005sec/0.030sec/12) 138B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]278Aug 30 15:10:05 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[522]: Sending registration request...279Aug 30 15:10:05 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[522]: Success!280Aug 30 15:10:05 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'threads_backfill'281Aug 30 15:10:05 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Running background update 'threads_backfill'. Processed 0 items in 5ms. (total_rate=None/ms, current_rate=None/ms, total_updated=0, batch_size=100)282Aug 30 15:10:06 machine synapse[492]: 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]283Aug 30 15:10:06 machine synapse[492]: synapse.handlers.auth: [POST-3] Logging in user @someuser:clan.test on device DCMAIIBEJN284Aug 30 15:10:06 machine synapse[492]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.303sec/0.001sec ru=(0.263sec, 0.003sec) db=(0.005sec/0.020sec/12) 145B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]285Aug 30 15:10:06 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[529]: Sending registration request...286Aug 30 15:10:06 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[529]: Success!287Aug 30 15:10:06 machine systemd[1]: Started Synapse Matrix homeserver.288Aug 30 15:10:06 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]289Aug 30 15:10:06 machine systemd[1]: Stopping Synapse Matrix homeserver...290Aug 30 15:10:06 machine synapse[492]: twisted: [sentinel] Received SIGTERM, shutting down.291Aug 30 15:10:06 machine synapse[492]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'device_lists_changes_in_room_by_room_index'292Aug 30 15:10:06 machine synapse[492]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropping held locks due to shutdown293Aug 30 15:10:06 machine synapse[492]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropped locks due to shutdown294Aug 30 15:10:06 machine synapse[492]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Performing _on_shutdown. Persisting 0 unpersisted changes295Aug 30 15:10:06 machine synapse[492]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Finished _on_shutdown296Aug 30 15:10:06 machine synapse[492]: synapse.app._base: [log_shutdown] Shutting down...297Aug 30 15:10:06 machine synapse[492]: twisted: [sentinel] (TCP Port 8008 Closed)298Aug 30 15:10:06 machine synapse[492]: twisted: [sentinel] Main loop terminated.299Aug 30 15:10:06 machine systemd[1]: matrix-synapse.service: Deactivated successfully.300Aug 30 15:10:06 machine systemd[1]: Stopped Synapse Matrix homeserver.301Aug 30 15:10:06 machine systemd[1]: matrix-synapse.service: Consumed 8.635s CPU time over 9.667s wall clock time.302Aug 30 15:10:06 machine systemd[1]: Starting Synapse Matrix homeserver...303Aug 30 15:10:12 machine synapse_homeserver[560]: This server is configured to use 'matrix.org' as its trusted key server via the304Aug 30 15:10:12 machine synapse_homeserver[560]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key305Aug 30 15:10:12 machine synapse_homeserver[560]: server since it is long-lived, stable and trusted. However, some admins may306Aug 30 15:10:12 machine synapse_homeserver[560]: wish to use another server for this purpose.307Aug 30 15:10:12 machine synapse_homeserver[560]: To suppress this warning and continue using 'matrix.org', admins should set308Aug 30 15:10:12 machine synapse_homeserver[560]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.309Aug 30 15:10:12 machine synapse_homeserver[560]: --------------------------------------------------------------------------------310Aug 30 15:10:12 machine synapse[560]: synapse.config.logger: [main] ***** STARTING SERVER *****311Aug 30 15:10:12 machine synapse[560]: synapse.config.logger: [main] Server /nix/store/1s8lqnc1k176xsjap48vxjq430ckjqnm-matrix-synapse-1.159.0/bin/synapse_homeserver version 1.159.0312Aug 30 15:10:12 machine synapse[560]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc313Aug 30 15:10:12 machine synapse[560]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse314Aug 30 15:10:12 machine synapse[560]: synapse.config.logger: [main] Server hostname: clan.test315Aug 30 15:10:12 machine synapse[560]: synapse.config.logger: [main] Public Base URL: https://clan.test/316Aug 30 15:10:12 machine synapse[560]: synapse.config.logger: [main] Instance name: master317Aug 30 15:10:12 machine synapse[560]: synapse.config.logger: [main] Twisted reactor: EPollReactor318Aug 30 15:10:12 machine synapse[560]: synapse.app.homeserver: [main] Setting up server319Aug 30 15:10:12 machine synapse[560]: synapse.server: [main] Setting up.320Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: Checking database server321Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']322Aug 30 15:10:12 machine synapse[560]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version323Aug 30 15:10:12 machine synapse[560]: synapse.storage.prepare_database: [main] ['main', 'state']: Existing schema is 94 (+12 deltas)324Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases.main: [main] Checking database for consistency with configuration...325Aug 30 15:10:12 machine synapse[560]: synapse.storage.prepare_database: [main] Applying schema deltas for v94326Aug 30 15:10:12 machine synapse[560]: synapse.storage.prepare_database: [main] Schema now up to date327Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database328Aug 30 15:10:12 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1329Aug 30 15:10:12 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1330Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago331Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0332Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago333Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0334Aug 30 15:10:12 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 3335Aug 30 15:10:12 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1336Aug 30 15:10:12 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1337Aug 30 15:10:12 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1338Aug 30 15:10:12 machine synapse[560]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1339Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database340Aug 30 15:10:12 machine synapse[560]: synapse.storage.databases: [main] [database config 'master']: prepared341Aug 30 15:10:12 machine synapse[560]: synapse.server: [main] Finished setting up.342Aug 30 15:10:12 machine synapse[560]: twisted: [main] Redirected stdout/stderr to logs343Aug 30 15:10:12 machine synapse[560]: synapse.app.homeserver: [main] Running344Aug 30 15:10:12 machine synapse[560]: synapse.app.homeserver: [main] Set file limit to: 524288345Aug 30 15:10:12 machine synapse[560]: synapse.push.pusher: [call_when_running] email enable notifs: False346Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'347Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'348Aug 30 15:10:12 machine synapse[560]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds349Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'350Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'351Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'352Aug 30 15:10:12 machine synapse[560]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter353Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'354Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'355Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'356Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'357Aug 30 15:10:12 machine synapse[560]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'358Aug 30 15:10:12 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffee0592a0> to path b'/health'359Aug 30 15:10:12 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffee3039a0> to path b'/_matrix/client'360Aug 30 15:10:12 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffee3096a0> to path b'/.well-known'361Aug 30 15:10:12 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffee303b20> to path b'/_synapse/admin'362Aug 30 15:10:12 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'363Aug 30 15:10:12 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffe1aa1e20> to path b'/_synapse/client/pick_username'364Aug 30 15:10:12 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'365Aug 30 15:10:12 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'366Aug 30 15:10:12 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'367Aug 30 15:10:12 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'368Aug 30 15:10:12 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'369Aug 30 15:10:12 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'370Aug 30 15:10:12 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'371Aug 30 15:10:12 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'372Aug 30 15:10:12 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffee30b620> to path b'/_matrix/federation'373Aug 30 15:10:12 machine synapse[560]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffee30e7a0> to path b'/_matrix/key'374Aug 30 15:10:12 machine synapse[560]: twisted: [call_when_running] SynapseSite starting on 8008375Aug 30 15:10:12 machine synapse[560]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008376Aug 30 15:10:12 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).377Aug 30 15:10:13 machine synapse[560]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master378Aug 30 15:10:13 machine synapse[560]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping379Aug 30 15:10:13 machine synapse[560]: synapse.push.pusherpool: [start_pushers-0] Started pushers380Aug 30 15:10:13 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[585]: Connection to ::1 8008 port [tcp/http-alt] succeeded!381Aug 30 15:10:13 machine synapse[560]: 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]382Aug 30 15:10:13 machine synapse[560]: synapse.http.server: [POST-1] <XForwardedForRequest at 0xffffe1aa4260 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.383Aug 30 15:10:13 machine synapse[560]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.248sec/0.000sec 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]384Aug 30 15:10:13 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[586]: Sending registration request...385Aug 30 15:10:13 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[586]: User already exists. Skipping.386Aug 30 15:10:14 machine synapse[560]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'device_lists_changes_in_room_by_room_index'387Aug 30 15:10:14 machine synapse[560]: synapse.storage.background_updates: [background_updates-0] Adding index device_lists_changes_in_room_by_room_idx to device_lists_changes_in_room388Aug 30 15:10:14 machine synapse[560]: 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)389Aug 30 15:10:14 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 30 15:10:14 machine synapse[560]: synapse.http.server: [POST-3] <XForwardedForRequest at 0xffffedba3960 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.391Aug 30 15:10:14 machine synapse[560]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.240sec/0.000sec ru=(0.237sec, 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 30 15:10:14 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[592]: Sending registration request...393Aug 30 15:10:14 machine wilq5k4l3zkskj1vfpl6p6ld63xg52f7-matrix-synapse-create-users[592]: User already exists. Skipping.394Aug 30 15:10:14 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