container-test-run-matrix-synapse
default.checks.aarch64-linux.matrix-synapse
· build #258
· raw
1additionally exposed symbols:2 machine,3 start_all, machines, driver, Machine, wait_for_signal4Starting machine567<<< NixOS Stage 2 >>>89booting system configuration /nix/store/8wgb64h7rkdqcp0li498w3mhk7f1gr2a-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/fz6id67gqf07rkbpmab99wmxspx2f9j5-coreutils-9.11/bin/sleep 999999999 && echo 3affedba-21ae-455b-b5a1-c55476f605df'29Running as unit: run-p475-i78296989.service; invocation ID: 2781d965caa849feac7274e7b3a3aade30To attach to container machine run on the same machine that runs the test:31 sudo nsenter --user --target $(\pgrep -f '^/bin/sh.*3affedba-21ae-455b-b5a1-c55476f605df') --mount --uts --ipc --net --pid --cgroup /bin/sh -c bash 3233To inject external network and continue test, run:34sudo /nix/store/db760w7nmr0a45hlfq8392a474f403aa-python3-3.13.14/bin/python3.13 /nix/store/x6z7fjvvivdicryh72s3czbafhpl69hc-test-driver-0.0.1/lib/python3.13/site-packages/test_driver/inject_network.py 3affedba-21ae-455b-b5a1-c55476f605df35+ 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 06 15:09:07 machine systemd[1]: Starting Synapse Matrix homeserver...52Aug 06 15:09:10 machine matrix-synapse-pre-start[480]: Generating signing key file /var/lib/matrix-synapse/homeserver.signing.key53Aug 06 15:09:14 machine synapse_homeserver[493]: This server is configured to use 'matrix.org' as its trusted key server via the54Aug 06 15:09:14 machine synapse_homeserver[493]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key55Aug 06 15:09:14 machine synapse_homeserver[493]: server since it is long-lived, stable and trusted. However, some admins may56Aug 06 15:09:14 machine synapse_homeserver[493]: wish to use another server for this purpose.57Aug 06 15:09:14 machine synapse_homeserver[493]: To suppress this warning and continue using 'matrix.org', admins should set58Aug 06 15:09:14 machine synapse_homeserver[493]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.59Aug 06 15:09:14 machine synapse_homeserver[493]: --------------------------------------------------------------------------------60Aug 06 15:09:14 machine synapse[493]: synapse.config.logger: [main] ***** STARTING SERVER *****61Aug 06 15:09:14 machine synapse[493]: synapse.config.logger: [main] Server /nix/store/6hnldga6yvkjc89sql0ivpi7x1iz5yh4-matrix-synapse-1.157.2/bin/synapse_homeserver version 1.157.262Aug 06 15:09:14 machine synapse[493]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc63Aug 06 15:09:14 machine synapse[493]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse64Aug 06 15:09:14 machine synapse[493]: synapse.config.logger: [main] Server hostname: clan.test65Aug 06 15:09:14 machine synapse[493]: synapse.config.logger: [main] Public Base URL: https://clan.test/66Aug 06 15:09:14 machine synapse[493]: synapse.config.logger: [main] Instance name: master67Aug 06 15:09:14 machine synapse[493]: synapse.config.logger: [main] Twisted reactor: EPollReactor68Aug 06 15:09:14 machine synapse[493]: synapse.app.homeserver: [main] Setting up server69Aug 06 15:09:14 machine synapse[493]: synapse.server: [main] Setting up.70Aug 06 15:09:14 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: Checking database server71Aug 06 15:09:14 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']72Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version73Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] ['main', 'state']: Initialising new database74Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v7375Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/01event_failed_pull_attempts.sql76Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/02add_pusher_enabled.sql77Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/02room_id_indexes_for_purging.sql78Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/03pusher_device_id.sql79Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/03users_approved_column.sql80Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/04partial_join_details.sql81Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/04pending_device_list_updates.sql82Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/05old_push_actions.sql.postgres83Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/06thread_notifications_thread_id_idx.sql84Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/08thread_receipts_non_null.sql.postgres85Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/09partial_joined_via_destination.sql86Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/09threads_table.sql87Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Running 73/10_update_sqlite_fts4_tokenizer.py:run_create88Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/10login_tokens.sql89Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/11event_search_room_id_n_distinct.sql.postgres90Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/12refactor_device_list_outbound_pokes.sql91Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/13add_device_lists_index.sql92Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/20_un_partial_stated_room_stream.sql93Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/21_un_partial_stated_room_stream_seq.sql.postgres94Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/22_rebuild_user_dir_stats.sql95Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/22_un_partial_stated_event_stream.sql96Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/23_fix_thread_index.sql97Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/23_un_partial_stated_room_stream_seq.sql.postgres98Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/24_events_jump_to_date_index.sql99Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 73/25drop_presence.sql100Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v74101Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/01_user_directory_stale_remote_users.sql102Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/02_set_device_id_for_pushers_bg_update.sql103Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/03_membership_tables_event_stream_ordering.sql.postgres104Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/03_room_membership_index.sql105Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/04_delete_e2e_backup_keys_for_deactivated_users.sql106Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Running 74/04_membership_tables_event_stream_ordering_triggers.py:run_create107Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 74/05_events_txn_id_device_id.sql108Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/90COMMENTS_destinations.sql.postgres109Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v75110Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v76111Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 76/01_add_profiles_full_user_id_column.sql112Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 76/02_add_user_filters_full_user_id_column.sql113Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 76/03_per_user_experimental_features.sql114Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 76/04_add_room_forgetter.sql115Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v77116Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/01_add_profiles_not_valid_check.sql.postgres117Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/02_add_user_filters_not_valid_check.sql.postgres118Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 77/03bg_populate_full_user_id_profiles.sql119Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 77/04bg_populate_full_user_id_user_filters.sql120Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 77/05thread_notifications_backfill.sql121Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions.sql.postgres122Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions_staging.sql.postgres123Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_summary.sql.postgres124Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 77/14bg_indices_event_stream_ordering.sql125Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v78126Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Running 78/03event_extremities_constraints.py:run_create127Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Running 78/04_add_full_user_id_index_user_filters.py:run_create128Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v79129Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/03_read_write_locks_triggers.sql.postgres130Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Running 79/04_mitigate_stream_ordering_update_race.py:run_create131Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/05_read_write_locks_triggers.sql.postgres132Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v80133Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 80/01_users_alter_locked.sql134Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/02_read_write_locks_unlogged.sql.postgres135Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 80/02_scheduled_tasks.sql136Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/03_read_write_locks_triggers.sql.postgres137Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/04_read_write_locks_deadlock.sql.postgres138Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v81139Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v82140Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 82/02_scheduled_tasks_index.sql141Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 82/04_add_indices_for_purging_rooms.sql142Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 82/05gaps.sql143Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v83144Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 83/01_drop_old_tables.sql145Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 83/05_cross_signing_key_update_grant.sql146Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 83/06_event_push_summary_room.sql147Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v84148Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/01_auth_links_stats.sql.postgres149Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 84/02_auth_links_index.sql150Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/03_auth_links_analyze.sql.postgres151Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 84/04_access_token_index.sql152Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v85153Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/01_add_suspended.sql154Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/02_add_instance_names.sql155Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 85/03_new_sequences.sql.postgres156Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/04_cleanup_device_federation_outbox.sql157Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/05_add_instance_names_converted_pos.sql158Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 85/06_add_room_reports.sql159Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v86160Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 86/01_authenticate_media.sql161Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 86/02_receipts_event_id_index.sql162Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v87163Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 87/01_sliding_sync_memberships.sql164Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 87/02_per_connection_state.sql165Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 87/03_current_state_index.sql166Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v88167Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/01_add_delayed_events.sql168Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/01_custom_profile_fields.sql169Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/02_fix_sliding_sync_membership_snapshots_forgotten_column.sql170Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/03_add_otk_ts_added_index.sql171Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/04_current_state_delta_index.sql172Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 88/05_drop_old_otks.sql.postgres173Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/05_sliding_sync_room_config_index.sql174Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 88/06_events_received_ts_index.sql175Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v89176Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 89/01_sliding_sync_membership_snapshot_index.sql177Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 89/01_state_groups_deletion.sql178Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v90179Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 90/01_add_column_participant_room_memberships_table.sql180Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 90/02_delete_unreferenced_state_groups.sql181Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 90/03_remove_old_deletion_bg_update.sql182Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v91183Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 91/01_media_hash.sql184Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v92185Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/01_remove_trigger.sql.postgres186Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/02_remove_populate_participant_bg_update.sql187Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/04_ss_membership_snapshot_idx.sql188Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/04_thread_subscriptions.sql189Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/04_thread_subscriptions_seq.sql.postgres190Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/05_fixup_max_depth_cap.sql191Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/05_thread_subscriptions_comments.sql.postgres192Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/06_device_federation_inbox_index.sql193Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/06_threads_last_sent_stream_ordering_comments.sql.postgres194Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/07_add_user_reports.sql195Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/07_event_txn_id_device_id_txn_id2.sql196Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/08_room_ban_redactions.sql197Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/08_thread_subscriptions_seq_fixup.sql.postgres198Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 92/09_thread_subscriptions_update.sql199Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/09_thread_subscriptions_update.sql.postgres200Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v93201Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 93/01_add_delayed_events.sql202Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 93/01_sticky_events.sql203Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 93/01_sticky_events_seq.sql.postgres204Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 93/02_sliding_sync_members.sql205Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 93/03_sss_pos_last_used.sql206Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Running 93/04_make_delayed_event_content_text.py:run_create207Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema deltas for v94208Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/01_redactions_recheck.sql209Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/02_redactions_recheck_bg_update.sql210Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/03_device_lists_room_timestamp.sql211Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/03_quarantined_media_tracking.sql212Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/03_quarantined_media_tracking_seq.sql.postgres213Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/03_state_dag_fwd_extrems.sql214Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/04_device_lists_changes_max_pruned.sql215Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/05_rerun_flag_existing_quarantined_media.sql216Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/06_sliding_sync_connections_last_used_ts_index.sql217Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Applying schema 94/07_sliding_sync_lazy_members_position_index.sql218Aug 06 15:09:14 machine synapse[493]: synapse.storage.prepare_database: [main] Schema now up to date219Aug 06 15:09:14 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database220Aug 06 15:09:14 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1221Aug 06 15:09:14 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1222Aug 06 15:09:14 machine synapse[493]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago223Aug 06 15:09:14 machine synapse[493]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0224Aug 06 15:09:14 machine synapse[493]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago225Aug 06 15:09:14 machine synapse[493]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0226Aug 06 15:09:14 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 1227Aug 06 15:09:14 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1228Aug 06 15:09:14 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1229Aug 06 15:09:14 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1230Aug 06 15:09:14 machine synapse[493]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1231Aug 06 15:09:14 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database232Aug 06 15:09:14 machine synapse[493]: synapse.storage.databases: [main] [database config 'master']: prepared233Aug 06 15:09:14 machine synapse[493]: synapse.server: [main] Finished setting up.234Aug 06 15:09:14 machine synapse[493]: twisted: [main] Redirected stdout/stderr to logs235Aug 06 15:09:14 machine synapse[493]: synapse.app.homeserver: [main] Running236Aug 06 15:09:14 machine synapse[493]: synapse.app.homeserver: [main] Set file limit to: 524288237Aug 06 15:09:14 machine synapse[493]: synapse.push.pusher: [call_when_running] email enable notifs: False238Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'239Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'240Aug 06 15:09:14 machine synapse[493]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds241Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'242Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'243Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'244Aug 06 15:09:14 machine synapse[493]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter245Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'246Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'247Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'248Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'249Aug 06 15:09:14 machine synapse[493]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'250Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffedf395a0> to path b'/health'251Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffee2f2620> to path b'/_matrix/client'252Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffee2f8320> to path b'/.well-known'253Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffee2f27a0> to path b'/_synapse/admin'254Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffee2f87a0> to path b'/_synapse/client/pick_idp'255Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffedc8c560> to path b'/_synapse/client/pick_username'256Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffee2f8da0> to path b'/_synapse/client/new_user_consent'257Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffee2f8f20> to path b'/_synapse/client/sso_register'258Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffee2f90a0> to path b'/_synapse/client/unsubscribe'259Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/6hnldga6yvkjc89sql0ivpi7x1iz5yh4-matrix-synapse-1.157.2/lib/python3.13/site-packages/synapse/static') to path b'/_matrix/static'260Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee2f9520> to path b'/_matrix/media/r0'261Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee2f9520> to path b'/_matrix/media/v3'262Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee2f9520> to path b'/_matrix/media/v1'263Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffee2fa120> to path b'/_matrix/federation'264Aug 06 15:09:14 machine synapse[493]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffee2fd2a0> to path b'/_matrix/key'265Aug 06 15:09:14 machine synapse[493]: twisted: [call_when_running] SynapseSite starting on 8008266Aug 06 15:09:14 machine synapse[493]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008267Aug 06 15:09:14 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 06 15:09:14 machine synapse[493]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master269Aug 06 15:09:14 machine synapse[493]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping270Aug 06 15:09:14 machine synapse[493]: synapse.push.pusherpool: [start_pushers-0] Started pushers271Aug 06 15:09:14 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[522]: Connection to ::1 8008 port [tcp/http-alt] succeeded!272Aug 06 15:09:15 machine synapse[493]: 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]273Aug 06 15:09:15 machine synapse[493]: synapse.handlers.auth: [POST-1] Logging in user @admin:clan.test on device MWNIMCNIXE274Aug 06 15:09:15 machine synapse[493]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.301sec/0.001sec ru=(0.257sec, 0.004sec) db=(0.005sec/0.031sec/12) 138B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]275Aug 06 15:09:15 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[523]: Sending registration request...276Aug 06 15:09:15 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[523]: Success!277Aug 06 15:09:15 machine synapse[493]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'threads_backfill'278Aug 06 15:09:15 machine synapse[493]: 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)279Aug 06 15:09:16 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 06 15:09:16 machine synapse[493]: synapse.handlers.auth: [POST-3] Logging in user @someuser:clan.test on device BKMDGADXJZ281Aug 06 15:09:16 machine synapse[493]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.280sec/0.001sec ru=(0.241sec, 0.007sec) db=(0.004sec/0.021sec/12) 145B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts]282Aug 06 15:09:16 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[530]: Sending registration request...283Aug 06 15:09:16 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[530]: Success!284Aug 06 15:09:16 machine systemd[1]: Started Synapse Matrix homeserver.285Aug 06 15:09:16 machine synapse[493]: 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]286Aug 06 15:09:16 machine systemd[1]: Stopping Synapse Matrix homeserver...287Aug 06 15:09:16 machine synapse[493]: twisted: [sentinel] Received SIGTERM, shutting down.288Aug 06 15:09:16 machine synapse[493]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropping held locks due to shutdown289Aug 06 15:09:16 machine synapse[493]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropped locks due to shutdown290Aug 06 15:09:16 machine synapse[493]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Performing _on_shutdown. Persisting 0 unpersisted changes291Aug 06 15:09:16 machine synapse[493]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Finished _on_shutdown292Aug 06 15:09:16 machine synapse[493]: synapse.app._base: [log_shutdown] Shutting down...293Aug 06 15:09:16 machine synapse[493]: twisted: [sentinel] (TCP Port 8008 Closed)294Aug 06 15:09:16 machine synapse[493]: twisted: [sentinel] Main loop terminated.295Aug 06 15:09:16 machine systemd[1]: matrix-synapse.service: Deactivated successfully.296Aug 06 15:09:16 machine systemd[1]: Stopped Synapse Matrix homeserver.297Aug 06 15:09:16 machine systemd[1]: matrix-synapse.service: Consumed 8.432s CPU time over 9.341s wall clock time.298Aug 06 15:09:16 machine systemd[1]: Starting Synapse Matrix homeserver...299Aug 06 15:09:23 machine synapse_homeserver[561]: This server is configured to use 'matrix.org' as its trusted key server via the300Aug 06 15:09:23 machine synapse_homeserver[561]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key301Aug 06 15:09:23 machine synapse_homeserver[561]: server since it is long-lived, stable and trusted. However, some admins may302Aug 06 15:09:23 machine synapse_homeserver[561]: wish to use another server for this purpose.303Aug 06 15:09:23 machine synapse_homeserver[561]: To suppress this warning and continue using 'matrix.org', admins should set304Aug 06 15:09:23 machine synapse_homeserver[561]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.305Aug 06 15:09:23 machine synapse_homeserver[561]: --------------------------------------------------------------------------------306Aug 06 15:09:23 machine synapse[561]: synapse.config.logger: [main] ***** STARTING SERVER *****307Aug 06 15:09:23 machine synapse[561]: synapse.config.logger: [main] Server /nix/store/6hnldga6yvkjc89sql0ivpi7x1iz5yh4-matrix-synapse-1.157.2/bin/synapse_homeserver version 1.157.2308Aug 06 15:09:23 machine synapse[561]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc309Aug 06 15:09:23 machine synapse[561]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse310Aug 06 15:09:23 machine synapse[561]: synapse.config.logger: [main] Server hostname: clan.test311Aug 06 15:09:23 machine synapse[561]: synapse.config.logger: [main] Public Base URL: https://clan.test/312Aug 06 15:09:23 machine synapse[561]: synapse.config.logger: [main] Instance name: master313Aug 06 15:09:23 machine synapse[561]: synapse.config.logger: [main] Twisted reactor: EPollReactor314Aug 06 15:09:23 machine synapse[561]: synapse.app.homeserver: [main] Setting up server315Aug 06 15:09:23 machine synapse[561]: synapse.server: [main] Setting up.316Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: Checking database server317Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']318Aug 06 15:09:23 machine synapse[561]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version319Aug 06 15:09:23 machine synapse[561]: synapse.storage.prepare_database: [main] ['main', 'state']: Existing schema is 94 (+10 deltas)320Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases.main: [main] Checking database for consistency with configuration...321Aug 06 15:09:23 machine synapse[561]: synapse.storage.prepare_database: [main] Applying schema deltas for v94322Aug 06 15:09:23 machine synapse[561]: synapse.storage.prepare_database: [main] Schema now up to date323Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database324Aug 06 15:09:23 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1325Aug 06 15:09:23 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1326Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago327Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0328Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago329Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0330Aug 06 15:09:23 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 3331Aug 06 15:09:23 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1332Aug 06 15:09:23 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1333Aug 06 15:09:23 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1334Aug 06 15:09:23 machine synapse[561]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1335Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database336Aug 06 15:09:23 machine synapse[561]: synapse.storage.databases: [main] [database config 'master']: prepared337Aug 06 15:09:23 machine synapse[561]: synapse.server: [main] Finished setting up.338Aug 06 15:09:23 machine synapse[561]: twisted: [main] Redirected stdout/stderr to logs339Aug 06 15:09:23 machine synapse[561]: synapse.app.homeserver: [main] Running340Aug 06 15:09:23 machine synapse[561]: synapse.app.homeserver: [main] Set file limit to: 524288341Aug 06 15:09:23 machine synapse[561]: synapse.push.pusher: [call_when_running] email enable notifs: False342Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'343Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'344Aug 06 15:09:23 machine synapse[561]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds345Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'346Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'347Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'348Aug 06 15:09:23 machine synapse[561]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter349Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'350Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'351Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'352Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'353Aug 06 15:09:23 machine synapse[561]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'354Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffedd59720> to path b'/health'355Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffee0c27a0> to path b'/_matrix/client'356Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffee0c84a0> to path b'/.well-known'357Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffee0c2920> to path b'/_synapse/admin'358Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffee0c8920> to path b'/_synapse/client/pick_idp'359Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffeda9c420> to path b'/_synapse/client/pick_username'360Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffee0c8f20> to path b'/_synapse/client/new_user_consent'361Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffee0c90a0> to path b'/_synapse/client/sso_register'362Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffee0c9220> to path b'/_synapse/client/unsubscribe'363Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/6hnldga6yvkjc89sql0ivpi7x1iz5yh4-matrix-synapse-1.157.2/lib/python3.13/site-packages/synapse/static') to path b'/_matrix/static'364Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee0c96a0> to path b'/_matrix/media/r0'365Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee0c96a0> to path b'/_matrix/media/v3'366Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffee0c96a0> to path b'/_matrix/media/v1'367Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffee0ca2a0> to path b'/_matrix/federation'368Aug 06 15:09:23 machine synapse[561]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffee0cd420> to path b'/_matrix/key'369Aug 06 15:09:23 machine synapse[561]: twisted: [call_when_running] SynapseSite starting on 8008370Aug 06 15:09:23 machine synapse[561]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008371Aug 06 15:09:23 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).372Aug 06 15:09:23 machine synapse[561]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master373Aug 06 15:09:23 machine synapse[561]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping374Aug 06 15:09:23 machine synapse[561]: synapse.push.pusherpool: [start_pushers-0] Started pushers375Aug 06 15:09:23 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[586]: Connection to ::1 8008 port [tcp/http-alt] succeeded!376Aug 06 15:09:23 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]377Aug 06 15:09:24 machine synapse[561]: synapse.http.server: [POST-1] <XForwardedForRequest at 0xffffeda97f60 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.378Aug 06 15:09:24 machine synapse[561]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.247sec/0.000sec ru=(0.241sec, 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]379Aug 06 15:09:24 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[587]: Sending registration request...380Aug 06 15:09:24 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[587]: User already exists. Skipping.381Aug 06 15:09:24 machine synapse[561]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'device_lists_changes_in_room_by_room_index'382Aug 06 15:09:24 machine synapse[561]: synapse.storage.background_updates: [background_updates-0] Adding index device_lists_changes_in_room_by_room_idx to device_lists_changes_in_room383Aug 06 15:09:24 machine synapse[561]: synapse.storage.background_updates: [background_updates-0] Running background update 'device_lists_changes_in_room_by_room_index'. Processed 1 items in 9ms. (total_rate=0.1111111111111111/ms, current_rate=0.11111111111111112/ms, total_updated=1, batch_size=100)384Aug 06 15:09:24 machine synapse[561]: 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]385Aug 06 15:09:25 machine synapse[561]: synapse.http.server: [POST-3] <XForwardedForRequest at 0xffffeda96f20 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.386Aug 06 15:09:25 machine synapse[561]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.243sec/0.000sec ru=(0.239sec, 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]387Aug 06 15:09:25 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[593]: Sending registration request...388Aug 06 15:09:25 machine vcsj677vwrvk3pyciazgw3pj2m117aaz-matrix-synapse-create-users[593]: User already exists. Skipping.389Aug 06 15:09:25 machine systemd[1]: Started Synapse Matrix homeserver.390+ systemctl --no-pager show matrix-synapse391+ nc -z -v ::1 8008392Connection to ::1 8008 port [tcp/http-alt] succeeded!393+ curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'394