container-test-run-matrix-synapse
default.checks.aarch64-linux.matrix-synapse
· build #284
· raw
1additionally exposed symbols:2 machine,3 start_all, machines, driver, Machine, wait_for_signal4Starting machine5678<<< NixOS Stage 2 >>>910booting system configuration /nix/store/rmjl1s4ijypkqlpw4jry2z9pafnbs96j-nixos-system-machine-test11running activation script...12setting up /etc...132: host0@if3: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN mode DEFAULT group default qlen 100014 link/ether 0e:74:26:22:81:c2 brd ff:ff:ff:ff:ff:ff link-netnsid 015setting up age secrets...16starting systemd...17systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)18Detected virtualization systemd-nspawn.19Detected architecture arm64.20Detected first boot.21Initializing machine ID from container UUID.22Applying preset policy.23Populated /etc with preset unit settings.24Queued start job for default target Multi-User System.25262728<<< Welcome to NixOS test (aarch64) - console >>>29+ systemd-run /bin/sh -c '/nix/store/p79fmimbb698sv4c135kbdwlhjcqpd3p-coreutils-9.11/bin/sleep 999999999 && echo bc6effb4-9390-4d41-9dc4-03bdfb88d3fc'30Running as unit: run-p484-i81657773.service; invocation ID: 2d4cc851bd2b46b5ad7ed6cc7edb53c131To attach to container machine run on the same machine that runs the test:32 sudo nsenter --user --target $(\pgrep -f '^/bin/sh.*bc6effb4-9390-4d41-9dc4-03bdfb88d3fc') --mount --uts --ipc --net --pid --cgroup /bin/sh -c bash 3334To inject external network and continue test, run:35sudo /nix/store/41m77i1296n33p6liin8ynr6wh3h6b7m-python3-3.14.6/bin/python3.14 /nix/store/5kaq06rm8h6acj0ggm4f0dswwr131zib-test-driver-0.0.1/lib/python3.14/site-packages/test_driver/inject_network.py bc6effb4-9390-4d41-9dc4-03bdfb88d3fc36+ 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+ systemctl --no-pager show matrix-synapse45+ systemctl --no-pager show matrix-synapse46+ systemctl --no-pager show matrix-synapse47+ nc -z -v ::1 800848Connection to ::1 8008 port [tcp/http-alt] succeeded!49machine: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'50+ curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'51(finished: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test', in 0.02 seconds)52+ systemctl restart matrix-synapse53+ journalctl -u matrix-synapse --no-pager54Aug 10 10:09:48 machine systemd[1]: Starting Synapse Matrix homeserver...55Aug 10 10:09:51 machine matrix-synapse-pre-start[479]: Generating signing key file /var/lib/matrix-synapse/homeserver.signing.key56Aug 10 10:09:55 machine synapse_homeserver[495]: This server is configured to use 'matrix.org' as its trusted key server via the57Aug 10 10:09:55 machine synapse_homeserver[495]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key58Aug 10 10:09:55 machine synapse_homeserver[495]: server since it is long-lived, stable and trusted. However, some admins may59Aug 10 10:09:55 machine synapse_homeserver[495]: wish to use another server for this purpose.60Aug 10 10:09:55 machine synapse_homeserver[495]: To suppress this warning and continue using 'matrix.org', admins should set61Aug 10 10:09:55 machine synapse_homeserver[495]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.62Aug 10 10:09:55 machine synapse_homeserver[495]: --------------------------------------------------------------------------------63Aug 10 10:09:55 machine synapse[495]: synapse.config.logger: [main] ***** STARTING SERVER *****64Aug 10 10:09:55 machine synapse[495]: synapse.config.logger: [main] Server /nix/store/riz7yc73j4nc15s82ppdcv1hny4vjkl2-matrix-synapse-1.157.2/bin/synapse_homeserver version 1.157.265Aug 10 10:09:55 machine synapse[495]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc66Aug 10 10:09:55 machine synapse[495]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse67Aug 10 10:09:55 machine synapse[495]: synapse.config.logger: [main] Server hostname: clan.test68Aug 10 10:09:55 machine synapse[495]: synapse.config.logger: [main] Public Base URL: https://clan.test/69Aug 10 10:09:55 machine synapse[495]: synapse.config.logger: [main] Instance name: master70Aug 10 10:09:55 machine synapse[495]: synapse.config.logger: [main] Twisted reactor: EPollReactor71Aug 10 10:09:55 machine synapse[495]: synapse.app.homeserver: [main] Setting up server72Aug 10 10:09:55 machine synapse[495]: synapse.server: [main] Setting up.73Aug 10 10:09:55 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: Checking database server74Aug 10 10:09:55 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']75Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version76Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] ['main', 'state']: Initialising new database77Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v7378Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/01event_failed_pull_attempts.sql79Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/02add_pusher_enabled.sql80Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/02room_id_indexes_for_purging.sql81Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/03pusher_device_id.sql82Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/03users_approved_column.sql83Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/04partial_join_details.sql84Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/04pending_device_list_updates.sql85Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/05old_push_actions.sql.postgres86Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/06thread_notifications_thread_id_idx.sql87Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/08thread_receipts_non_null.sql.postgres88Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/09partial_joined_via_destination.sql89Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/09threads_table.sql90Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Running 73/10_update_sqlite_fts4_tokenizer.py:run_create91Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/10login_tokens.sql92Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/11event_search_room_id_n_distinct.sql.postgres93Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/12refactor_device_list_outbound_pokes.sql94Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/13add_device_lists_index.sql95Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/20_un_partial_stated_room_stream.sql96Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/21_un_partial_stated_room_stream_seq.sql.postgres97Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/22_rebuild_user_dir_stats.sql98Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/22_un_partial_stated_event_stream.sql99Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/23_fix_thread_index.sql100Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/23_un_partial_stated_room_stream_seq.sql.postgres101Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/24_events_jump_to_date_index.sql102Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 73/25drop_presence.sql103Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v74104Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/01_user_directory_stale_remote_users.sql105Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/02_set_device_id_for_pushers_bg_update.sql106Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/03_membership_tables_event_stream_ordering.sql.postgres107Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/03_room_membership_index.sql108Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/04_delete_e2e_backup_keys_for_deactivated_users.sql109Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Running 74/04_membership_tables_event_stream_ordering_triggers.py:run_create110Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 74/05_events_txn_id_device_id.sql111Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/90COMMENTS_destinations.sql.postgres112Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v75113Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v76114Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 76/01_add_profiles_full_user_id_column.sql115Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 76/02_add_user_filters_full_user_id_column.sql116Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 76/03_per_user_experimental_features.sql117Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 76/04_add_room_forgetter.sql118Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v77119Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/01_add_profiles_not_valid_check.sql.postgres120Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/02_add_user_filters_not_valid_check.sql.postgres121Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 77/03bg_populate_full_user_id_profiles.sql122Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 77/04bg_populate_full_user_id_user_filters.sql123Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 77/05thread_notifications_backfill.sql124Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions.sql.postgres125Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions_staging.sql.postgres126Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_summary.sql.postgres127Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 77/14bg_indices_event_stream_ordering.sql128Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v78129Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Running 78/03event_extremities_constraints.py:run_create130Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Running 78/04_add_full_user_id_index_user_filters.py:run_create131Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v79132Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/03_read_write_locks_triggers.sql.postgres133Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Running 79/04_mitigate_stream_ordering_update_race.py:run_create134Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/05_read_write_locks_triggers.sql.postgres135Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v80136Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 80/01_users_alter_locked.sql137Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/02_read_write_locks_unlogged.sql.postgres138Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 80/02_scheduled_tasks.sql139Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/03_read_write_locks_triggers.sql.postgres140Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/04_read_write_locks_deadlock.sql.postgres141Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v81142Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v82143Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 82/02_scheduled_tasks_index.sql144Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 82/04_add_indices_for_purging_rooms.sql145Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 82/05gaps.sql146Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v83147Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 83/01_drop_old_tables.sql148Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 83/05_cross_signing_key_update_grant.sql149Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 83/06_event_push_summary_room.sql150Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v84151Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/01_auth_links_stats.sql.postgres152Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 84/02_auth_links_index.sql153Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/03_auth_links_analyze.sql.postgres154Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 84/04_access_token_index.sql155Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v85156Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/01_add_suspended.sql157Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/02_add_instance_names.sql158Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 85/03_new_sequences.sql.postgres159Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/04_cleanup_device_federation_outbox.sql160Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/05_add_instance_names_converted_pos.sql161Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 85/06_add_room_reports.sql162Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v86163Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 86/01_authenticate_media.sql164Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 86/02_receipts_event_id_index.sql165Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v87166Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 87/01_sliding_sync_memberships.sql167Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 87/02_per_connection_state.sql168Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 87/03_current_state_index.sql169Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v88170Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/01_add_delayed_events.sql171Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/01_custom_profile_fields.sql172Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/02_fix_sliding_sync_membership_snapshots_forgotten_column.sql173Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/03_add_otk_ts_added_index.sql174Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/04_current_state_delta_index.sql175Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 88/05_drop_old_otks.sql.postgres176Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/05_sliding_sync_room_config_index.sql177Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 88/06_events_received_ts_index.sql178Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v89179Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 89/01_sliding_sync_membership_snapshot_index.sql180Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 89/01_state_groups_deletion.sql181Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v90182Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 90/01_add_column_participant_room_memberships_table.sql183Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 90/02_delete_unreferenced_state_groups.sql184Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 90/03_remove_old_deletion_bg_update.sql185Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v91186Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 91/01_media_hash.sql187Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v92188Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/01_remove_trigger.sql.postgres189Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/02_remove_populate_participant_bg_update.sql190Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/04_ss_membership_snapshot_idx.sql191Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/04_thread_subscriptions.sql192Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/04_thread_subscriptions_seq.sql.postgres193Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/05_fixup_max_depth_cap.sql194Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/05_thread_subscriptions_comments.sql.postgres195Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/06_device_federation_inbox_index.sql196Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/06_threads_last_sent_stream_ordering_comments.sql.postgres197Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/07_add_user_reports.sql198Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/07_event_txn_id_device_id_txn_id2.sql199Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/08_room_ban_redactions.sql200Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/08_thread_subscriptions_seq_fixup.sql.postgres201Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 92/09_thread_subscriptions_update.sql202Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/09_thread_subscriptions_update.sql.postgres203Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v93204Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 93/01_add_delayed_events.sql205Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 93/01_sticky_events.sql206Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 93/01_sticky_events_seq.sql.postgres207Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 93/02_sliding_sync_members.sql208Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 93/03_sss_pos_last_used.sql209Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Running 93/04_make_delayed_event_content_text.py:run_create210Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema deltas for v94211Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/01_redactions_recheck.sql212Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/02_redactions_recheck_bg_update.sql213Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/03_device_lists_room_timestamp.sql214Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/03_quarantined_media_tracking.sql215Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/03_quarantined_media_tracking_seq.sql.postgres216Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/03_state_dag_fwd_extrems.sql217Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/04_device_lists_changes_max_pruned.sql218Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/05_rerun_flag_existing_quarantined_media.sql219Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/06_sliding_sync_connections_last_used_ts_index.sql220Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Applying schema 94/07_sliding_sync_lazy_members_position_index.sql221Aug 10 10:09:55 machine synapse[495]: synapse.storage.prepare_database: [main] Schema now up to date222Aug 10 10:09:55 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database223Aug 10 10:09:56 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1224Aug 10 10:09:56 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1225Aug 10 10:09:56 machine synapse[495]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago226Aug 10 10:09:56 machine synapse[495]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0227Aug 10 10:09:56 machine synapse[495]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago228Aug 10 10:09:56 machine synapse[495]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0229Aug 10 10:09:56 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 1230Aug 10 10:09:56 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1231Aug 10 10:09:56 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1232Aug 10 10:09:56 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1233Aug 10 10:09:56 machine synapse[495]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1234Aug 10 10:09:56 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database235Aug 10 10:09:56 machine synapse[495]: synapse.storage.databases: [main] [database config 'master']: prepared236Aug 10 10:09:56 machine synapse[495]: synapse.server: [main] Finished setting up.237Aug 10 10:09:56 machine synapse[495]: twisted: [main] Redirected stdout/stderr to logs238Aug 10 10:09:56 machine synapse[495]: synapse.app.homeserver: [main] Running239Aug 10 10:09:56 machine synapse[495]: synapse.app.homeserver: [main] Set file limit to: 524288240Aug 10 10:09:56 machine synapse[495]: synapse.push.pusher: [call_when_running] email enable notifs: False241Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'242Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'243Aug 10 10:09:56 machine synapse[495]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds244Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'245Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'246Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'247Aug 10 10:09:56 machine synapse[495]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter248Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'249Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'250Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'251Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'252Aug 10 10:09:56 machine synapse[495]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'253Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffec6524a0> to path b'/health'254Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffec66a1a0> to path b'/_matrix/client'255Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffec66fea0> to path b'/.well-known'256Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffec66a320> to path b'/_synapse/admin'257Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffec830320> to path b'/_synapse/client/pick_idp'258Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffec2fdf20> to path b'/_synapse/client/pick_username'259Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffec830920> to path b'/_synapse/client/new_user_consent'260Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffec830aa0> to path b'/_synapse/client/sso_register'261Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffec830c20> to path b'/_synapse/client/unsubscribe'262Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/riz7yc73j4nc15s82ppdcv1hny4vjkl2-matrix-synapse-1.157.2/lib/python3.14/site-packages/synapse/static') to path b'/_matrix/static'263Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec8310a0> to path b'/_matrix/media/r0'264Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec8310a0> to path b'/_matrix/media/v3'265Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec8310a0> to path b'/_matrix/media/v1'266Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffec831ca0> to path b'/_matrix/federation'267Aug 10 10:09:56 machine synapse[495]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffec834e20> to path b'/_matrix/key'268Aug 10 10:09:56 machine synapse[495]: twisted: [call_when_running] SynapseSite starting on 8008269Aug 10 10:09:56 machine synapse[495]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008270Aug 10 10:09:56 machine synapse[495]: synapse.app._base: [call_when_running] garbage collector: Freezing all allocated objects in the hopes that (almost) everything currently allocated are things that will be used by the homeserver for the rest of time. Doing so means less work each GC (hopefully).271Aug 10 10:09:56 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master272Aug 10 10:09:56 machine synapse[495]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping273Aug 10 10:09:56 machine synapse[495]: synapse.push.pusherpool: [start_pushers-0] Started pushers274Aug 10 10:09:57 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'threads_backfill'275Aug 10 10:09:57 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Running background update 'threads_backfill'. Processed 0 items in 10ms. (total_rate=None/ms, current_rate=None/ms, total_updated=0, batch_size=100)276Aug 10 10:09:57 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[526]: Connection to ::1 8008 port [tcp/http-alt] succeeded!277Aug 10 10:09:58 machine synapse[495]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.001sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]278Aug 10 10:09:58 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'device_lists_changes_in_room_by_room_index'279Aug 10 10:09:58 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Adding index device_lists_changes_in_room_by_room_idx to device_lists_changes_in_room280Aug 10 10:09:58 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Running background update 'device_lists_changes_in_room_by_room_index'. Processed 1 items in 6ms. (total_rate=0.16666666666666666/ms, current_rate=0.16666666666666666/ms, total_updated=1, batch_size=100)281Aug 10 10:09:58 machine synapse[495]: synapse.handlers.auth: [POST-1] Logging in user @admin:clan.test on device VONVNMZSZD282Aug 10 10:09:58 machine synapse[495]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.276sec/0.003sec ru=(0.243sec, 0.000sec) db=(0.003sec/0.022sec/12) 138B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]283Aug 10 10:09:58 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[527]: Sending registration request...284Aug 10 10:09:58 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[527]: Success!285Aug 10 10:09:59 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'populate_stats_process_rooms'286Aug 10 10:09:59 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Running background update 'populate_stats_process_rooms'. Processed 1 items in 3ms. (total_rate=0.3333333333333333/ms, current_rate=0.3333333333333333/ms, total_updated=1, batch_size=100)287Aug 10 10:09:59 machine synapse[495]: synapse.access.http.8008: [GET-2] ::1 - 8008 - {None} Processed request: 0.000sec/0.000sec ru=(0.001sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]288Aug 10 10:09:59 machine synapse[495]: synapse.handlers.auth: [POST-3] Logging in user @someuser:clan.test on device HHZHRBAASZ289Aug 10 10:09:59 machine synapse[495]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.263sec/0.000sec ru=(0.235sec, 0.001sec) db=(0.002sec/0.020sec/12) 145B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]290Aug 10 10:09:59 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[534]: Sending registration request...291Aug 10 10:09:59 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[534]: Success!292Aug 10 10:10:00 machine systemd[1]: Started Synapse Matrix homeserver.293Aug 10 10:10:00 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'populate_stats_process_users'294Aug 10 10:10:00 machine synapse[495]: synapse.storage.background_updates: [background_updates-0] Running background update 'populate_stats_process_users'. Processed 2 items in 17ms. (total_rate=0.11764705882352941/ms, current_rate=0.11764705882352941/ms, total_updated=2, batch_size=100)295Aug 10 10:10:00 machine synapse[495]: 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]296Aug 10 10:10:00 machine systemd[1]: Stopping Synapse Matrix homeserver...297Aug 10 10:10:00 machine synapse[495]: twisted: [sentinel] Received SIGTERM, shutting down.298Aug 10 10:10:00 machine synapse[495]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropping held locks due to shutdown299Aug 10 10:10:00 machine synapse[495]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropped locks due to shutdown300Aug 10 10:10:00 machine synapse[495]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Performing _on_shutdown. Persisting 0 unpersisted changes301Aug 10 10:10:00 machine synapse[495]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Finished _on_shutdown302Aug 10 10:10:00 machine synapse[495]: synapse.app._base: [log_shutdown] Shutting down...303Aug 10 10:10:00 machine synapse[495]: twisted: [sentinel] (TCP Port 8008 Closed)304Aug 10 10:10:00 machine synapse[495]: twisted: [sentinel] Main loop terminated.305Aug 10 10:10:00 machine systemd[1]: matrix-synapse.service: Deactivated successfully.306Aug 10 10:10:00 machine systemd[1]: Stopped Synapse Matrix homeserver.307Aug 10 10:10:00 machine systemd[1]: matrix-synapse.service: Consumed 9.101s CPU time over 12.129s wall clock time.308Aug 10 10:10:00 machine systemd[1]: Starting Synapse Matrix homeserver...309Aug 10 10:10:08 machine synapse_homeserver[566]: This server is configured to use 'matrix.org' as its trusted key server via the310Aug 10 10:10:08 machine synapse_homeserver[566]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key311Aug 10 10:10:08 machine synapse_homeserver[566]: server since it is long-lived, stable and trusted. However, some admins may312Aug 10 10:10:08 machine synapse_homeserver[566]: wish to use another server for this purpose.313Aug 10 10:10:08 machine synapse_homeserver[566]: To suppress this warning and continue using 'matrix.org', admins should set314Aug 10 10:10:08 machine synapse_homeserver[566]: 'suppress_key_server_warning' to 'true' in homeserver.yaml.315Aug 10 10:10:08 machine synapse_homeserver[566]: --------------------------------------------------------------------------------316Aug 10 10:10:08 machine synapse[566]: synapse.config.logger: [main] ***** STARTING SERVER *****317Aug 10 10:10:08 machine synapse[566]: synapse.config.logger: [main] Server /nix/store/riz7yc73j4nc15s82ppdcv1hny4vjkl2-matrix-synapse-1.157.2/bin/synapse_homeserver version 1.157.2318Aug 10 10:10:08 machine synapse[566]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc319Aug 10 10:10:08 machine synapse[566]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse320Aug 10 10:10:08 machine synapse[566]: synapse.config.logger: [main] Server hostname: clan.test321Aug 10 10:10:08 machine synapse[566]: synapse.config.logger: [main] Public Base URL: https://clan.test/322Aug 10 10:10:08 machine synapse[566]: synapse.config.logger: [main] Instance name: master323Aug 10 10:10:08 machine synapse[566]: synapse.config.logger: [main] Twisted reactor: EPollReactor324Aug 10 10:10:08 machine synapse[566]: synapse.app.homeserver: [main] Setting up server325Aug 10 10:10:08 machine synapse[566]: synapse.server: [main] Setting up.326Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases: [main] [database config 'master']: Checking database server327Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state']328Aug 10 10:10:08 machine synapse[566]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version329Aug 10 10:10:08 machine synapse[566]: synapse.storage.prepare_database: [main] ['main', 'state']: Existing schema is 94 (+10 deltas)330Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases.main: [main] Checking database for consistency with configuration...331Aug 10 10:10:08 machine synapse[566]: synapse.storage.prepare_database: [main] Applying schema deltas for v94332Aug 10 10:10:08 machine synapse[566]: synapse.storage.prepare_database: [main] Schema now up to date333Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database334Aug 10 10:10:08 machine synapse[566]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1335Aug 10 10:10:08 machine synapse[566]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1336Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago337Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0338Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago339Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0340Aug 10 10:10:08 machine synapse[566]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 3341Aug 10 10:10:08 machine synapse[566]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1342Aug 10 10:10:08 machine synapse[566]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1343Aug 10 10:10:08 machine synapse[566]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1344Aug 10 10:10:08 machine synapse[566]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1345Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database346Aug 10 10:10:08 machine synapse[566]: synapse.storage.databases: [main] [database config 'master']: prepared347Aug 10 10:10:08 machine synapse[566]: synapse.server: [main] Finished setting up.348Aug 10 10:10:08 machine synapse[566]: twisted: [main] Redirected stdout/stderr to logs349Aug 10 10:10:08 machine synapse[566]: synapse.app.homeserver: [main] Running350Aug 10 10:10:08 machine synapse[566]: synapse.app.homeserver: [main] Set file limit to: 524288351Aug 10 10:10:08 machine synapse[566]: synapse.push.pusher: [call_when_running] email enable notifs: False352Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile'353Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update'354Aug 10 10:10:08 machine synapse[566]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds355Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence'356Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing'357Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory'358Aug 10 10:10:08 machine synapse[566]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter359Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt'360Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update'361Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update'362Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys'363Aug 10 10:10:08 machine synapse[566]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device'364Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.health.HealthResource object at 0xffffec632c20> to path b'/health'365Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.EncodingResourceWrapper object at 0xffffec64a920> to path b'/_matrix/client'366Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffec840620> to path b'/.well-known'367Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.http.server.JsonResource object at 0xffffec64aaa0> to path b'/_synapse/admin'368Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.pick_idp.PickIdpResource object at 0xffffec840aa0> to path b'/_synapse/client/pick_idp'369Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <twisted.web.resource.Resource object at 0xffffec2ee6a0> to path b'/_synapse/client/pick_username'370Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.new_user_consent.NewUserConsentResource object at 0xffffec8410a0> to path b'/_synapse/client/new_user_consent'371Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.sso_register.SsoRegisterResource object at 0xffffec841220> to path b'/_synapse/client/sso_register'372Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.synapse.client.unsubscribe.UnsubscribeResource object at 0xffffec8413a0> to path b'/_synapse/client/unsubscribe'373Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/riz7yc73j4nc15s82ppdcv1hny4vjkl2-matrix-synapse-1.157.2/lib/python3.14/site-packages/synapse/static') to path b'/_matrix/static'374Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec841820> to path b'/_matrix/media/r0'375Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec841820> to path b'/_matrix/media/v3'376Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.media.media_repository_resource.MediaRepositoryResource object at 0xffffec841820> to path b'/_matrix/media/v1'377Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.federation.transport.server.TransportLayerServer object at 0xffffec842420> to path b'/_matrix/federation'378Aug 10 10:10:08 machine synapse[566]: synapse.util.httpresourcetree: [call_when_running] Attaching <synapse.rest.key.v2.KeyResource object at 0xffffec8455a0> to path b'/_matrix/key'379Aug 10 10:10:08 machine synapse[566]: twisted: [call_when_running] SynapseSite starting on 8008380Aug 10 10:10:08 machine synapse[566]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008381Aug 10 10:10:08 machine synapse[566]: 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).382Aug 10 10:10:08 machine synapse[566]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master383Aug 10 10:10:08 machine synapse[566]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping384Aug 10 10:10:08 machine synapse[566]: synapse.push.pusherpool: [start_pushers-0] Started pushers385Aug 10 10:10:08 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[591]: Connection to ::1 8008 port [tcp/http-alt] succeeded!386Aug 10 10:10:09 machine synapse[566]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.001sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]387Aug 10 10:10:09 machine synapse[566]: synapse.http.server: [POST-1] <XForwardedForRequest at 0xffffec2e7120 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.388Aug 10 10:10:09 machine synapse[566]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.235sec/0.000sec ru=(0.229sec, 0.000sec) db=(0.000sec/0.001sec/1) 60B 400 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]389Aug 10 10:10:09 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[592]: Sending registration request...390Aug 10 10:10:09 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[592]: User already exists. Skipping.391Aug 10 10:10:09 machine synapse[566]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'populate_stats_process_users'392Aug 10 10:10:09 machine synapse[566]: synapse.storage.background_updates: [background_updates-0] Running background update 'populate_stats_process_users'. Processed 1 items in 4ms. (total_rate=0.25/ms, current_rate=0.25/ms, total_updated=1, batch_size=100)393Aug 10 10:10:09 machine synapse[566]: synapse.storage.background_updates: [background_updates-0] Not starting on bg update populate_user_directory_cleanup until populate_user_directory_process_users is done394Aug 10 10:10:09 machine synapse[566]: 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.34.2" [0 dbevts]395Aug 10 10:10:10 machine synapse[566]: synapse.http.server: [POST-3] <XForwardedForRequest at 0xffffec2c43a0 method='POST' uri='/_synapse/admin/v1/register' clientproto='HTTP/1.1' site='8008'> SynapseError: 400 - User ID already taken.396Aug 10 10:10:10 machine synapse[566]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.234sec/0.000sec ru=(0.231sec, 0.000sec) db=(0.000sec/0.001sec/1) 60B 400 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.34.2" [0 dbevts]397Aug 10 10:10:10 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[598]: Sending registration request...398Aug 10 10:10:10 machine cn13b1nshdv753z6kf85wd6sxck0cqd2-matrix-synapse-create-users[598]: User already exists. Skipping.399Aug 10 10:10:10 machine systemd[1]: Started Synapse Matrix homeserver.400+ systemctl --no-pager show matrix-synapse401+ nc -z -v ::1 8008402Connection to ::1 8008 port [tcp/http-alt] succeeded!403+ curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test'404