2025-08-25T02:16:41.405045Z WARN conduwuit_core::config::check: Note: conduwuit was built without optimisations (i.e. debug build) 2025-08-25T02:16:41.405063Z DEBUG conduwuit_core::config::check: Checking for deprecated config keys 2025-08-25T02:16:41.405068Z DEBUG conduwuit_core::config::check: Checking for unknown config keys 2025-08-25T02:16:41.405082Z INFO conduwuit_core::config::check: Found loopback listening address 127.0.0.1:8448, running checks if we're in a container. 2025-08-25T02:16:41.405107Z INFO conduwuit_core::config::check: Found loopback listening address [::1]:8448, running checks if we're in a container. 2025-08-25T02:16:41.405665Z WARN conduwuit_core::config::check: Open registration is enabled via setting `yes_i_am_very_very_sure_i_want_an_open_registration_server_prone_to_abuse` and `allow_registration` to true without a registration token configured. You are expected to be aware of the risks now. If this is not the desired behaviour, please set a registration token. 2025-08-25T02:16:41.405673Z WARN conduwuit_core::config::check: No support contact information (support_email or support_mxid) is configured in the well_known section. Users in the admin room will be automatically listed as support contacts in the /.well-known/matrix/support endpoint. 2025-08-25T02:16:41.405686Z DEBUG conduwuit_core::utils::sys: Raised RLIMIT_NOFILE to=1048576 from=1024 2025-08-25T02:16:41.405692Z INFO conduwuit::server: 0.5.0-rc.6 (0826222b) server_name=continuwuity.localhost:8448 database_path="./continuwuity-database" log_levels=debug,h2=off,tower_http=off,hickory=off,hickory_proto=off,conduwuit_api::router::args=off,conduwuit_core::matrix::state_res=trace 2025-08-25T02:16:41.405886Z DEBUG main:start: conduwuit_router::run: Starting... 2025-08-25T02:16:41.406112Z ERROR main:start: conduwuit_core::error::log: I/O error: DEVNAME not found. 2025-08-25T02:16:41.406153Z DEBUG main:start: conduwuit_database::pool::configure: Updated global stream width scale=1.0 num_queues=1 req_width=64 old_width=32 new_width=64 old_amp=1024 new_amp=1024 2025-08-25T02:16:41.406169Z INFO main:start: conduwuit_database::pool::configure: Frontend topology device_name="None" worker_counts=[64] queue_sizes=[256] total_workers=64 stream_width=64 2025-08-25T02:16:41.406494Z DEBUG worker{id=0 tid=ThreadId(18)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406514Z DEBUG worker{id=1 tid=ThreadId(19)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406542Z DEBUG worker{id=2 tid=ThreadId(20)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406620Z DEBUG worker{id=3 tid=ThreadId(21)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406672Z DEBUG worker{id=4 tid=ThreadId(22)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406705Z DEBUG worker{id=6 tid=ThreadId(24)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406710Z DEBUG worker{id=5 tid=ThreadId(23)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406757Z DEBUG worker{id=7 tid=ThreadId(25)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406817Z DEBUG worker{id=8 tid=ThreadId(26)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406883Z DEBUG worker{id=9 tid=ThreadId(27)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406907Z DEBUG worker{id=10 tid=ThreadId(28)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406955Z DEBUG worker{id=11 tid=ThreadId(29)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.406981Z DEBUG worker{id=12 tid=ThreadId(30)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407062Z DEBUG worker{id=13 tid=ThreadId(31)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407093Z DEBUG worker{id=14 tid=ThreadId(32)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407143Z DEBUG worker{id=15 tid=ThreadId(33)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407211Z DEBUG worker{id=16 tid=ThreadId(34)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407237Z DEBUG worker{id=17 tid=ThreadId(35)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407270Z DEBUG worker{id=18 tid=ThreadId(36)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407322Z DEBUG worker{id=19 tid=ThreadId(37)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407370Z DEBUG worker{id=20 tid=ThreadId(38)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407409Z DEBUG worker{id=22 tid=ThreadId(40)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407420Z DEBUG worker{id=21 tid=ThreadId(39)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407462Z DEBUG worker{id=23 tid=ThreadId(41)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407488Z DEBUG worker{id=24 tid=ThreadId(42)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407529Z DEBUG worker{id=25 tid=ThreadId(43)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407556Z DEBUG worker{id=26 tid=ThreadId(44)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407636Z DEBUG worker{id=27 tid=ThreadId(45)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407717Z DEBUG worker{id=28 tid=ThreadId(46)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407779Z DEBUG worker{id=29 tid=ThreadId(47)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407791Z DEBUG worker{id=30 tid=ThreadId(48)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407832Z DEBUG worker{id=31 tid=ThreadId(49)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407847Z DEBUG worker{id=32 tid=ThreadId(50)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407893Z DEBUG worker{id=34 tid=ThreadId(52)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407895Z DEBUG worker{id=33 tid=ThreadId(51)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.407991Z DEBUG worker{id=36 tid=ThreadId(54)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408001Z DEBUG worker{id=35 tid=ThreadId(53)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408030Z DEBUG worker{id=37 tid=ThreadId(55)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408108Z DEBUG worker{id=38 tid=ThreadId(56)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408117Z DEBUG worker{id=39 tid=ThreadId(57)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408181Z DEBUG worker{id=40 tid=ThreadId(58)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408195Z DEBUG worker{id=41 tid=ThreadId(59)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408258Z DEBUG worker{id=42 tid=ThreadId(60)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408274Z DEBUG worker{id=43 tid=ThreadId(61)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408376Z DEBUG worker{id=44 tid=ThreadId(62)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408436Z DEBUG worker{id=46 tid=ThreadId(64)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408451Z DEBUG worker{id=47 tid=ThreadId(65)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408467Z DEBUG worker{id=45 tid=ThreadId(63)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408575Z DEBUG worker{id=48 tid=ThreadId(66)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408624Z DEBUG worker{id=49 tid=ThreadId(67)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408651Z DEBUG worker{id=50 tid=ThreadId(68)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408674Z DEBUG worker{id=51 tid=ThreadId(69)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408737Z DEBUG worker{id=53 tid=ThreadId(71)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408746Z DEBUG worker{id=52 tid=ThreadId(70)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408797Z DEBUG worker{id=54 tid=ThreadId(72)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408851Z DEBUG worker{id=55 tid=ThreadId(73)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408903Z DEBUG worker{id=56 tid=ThreadId(74)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408919Z DEBUG worker{id=57 tid=ThreadId(75)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.408996Z DEBUG worker{id=58 tid=ThreadId(76)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.409062Z DEBUG worker{id=59 tid=ThreadId(77)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.409136Z DEBUG worker{id=60 tid=ThreadId(78)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.409143Z DEBUG worker{id=61 tid=ThreadId(79)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.409192Z DEBUG worker{id=62 tid=ThreadId(80)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.409242Z DEBUG worker{id=63 tid=ThreadId(81)}: conduwuit_database::pool: worker ready group=0 affinity=[] 2025-08-25T02:16:41.409533Z DEBUG main:start:open:configure: conduwuit_database::engine::open: Discovered database columns existing=90 described=89 missing=0 creating=0 2025-08-25T02:16:41.424875Z DEBUG main:start:open: conduwuit_database::engine::open: Configured 89 column descriptors... 2025-08-25T02:16:41.424893Z DEBUG main:start:open: conduwuit_database::engine::open: Opening database... 2025-08-25T02:16:41.426563Z DEBUG main:start:open: conduwuit_database::engine::logger: RocksDB version: 10.1.0 2025-08-25T02:16:41.426628Z DEBUG main:start:open: conduwuit_database::engine::logger: Compile date 1970-01-01 00:00:00 2025-08-25T02:16:41.426640Z DEBUG main:start:open: conduwuit_database::engine::logger: DB SUMMARY 2025-08-25T02:16:41.426649Z DEBUG main:start:open: conduwuit_database::engine::logger: Host name (Env): ivy 2025-08-25T02:16:41.426656Z DEBUG main:start:open: conduwuit_database::engine::logger: DB Session ID: TJAK25ZFO504QJ3RU7WC 2025-08-25T02:16:41.426784Z DEBUG main:start:open: conduwuit_database::engine::logger: CURRENT file: CURRENT 2025-08-25T02:16:41.426796Z DEBUG main:start:open: conduwuit_database::engine::logger: IDENTITY file: IDENTITY 2025-08-25T02:16:41.426807Z DEBUG main:start:open: conduwuit_database::engine::logger: MANIFEST file: MANIFEST-001434 size: 36323 Bytes 2025-08-25T02:16:41.426815Z DEBUG main:start:open: conduwuit_database::engine::logger: SST files in ./continuwuity-database dir, Total Num: 147, files: 000008.sst 000009.sst 000010.sst 000011.sst 000012.sst 000017.sst 000018.sst 000020.sst 000021.sst 2025-08-25T02:16:41.426822Z DEBUG main:start:open: conduwuit_database::engine::logger: Write Ahead Log file in ./continuwuity-database: 001433.log size: 8024 ; 2025-08-25T02:16:41.426995Z DEBUG main:start:open: conduwuit_database::engine::logger: Compression algorithms supported: 2025-08-25T02:16:41.427004Z DEBUG main:start:open: conduwuit_database::engine::logger: kZSTD supported: 1 2025-08-25T02:16:41.427012Z DEBUG main:start:open: conduwuit_database::engine::logger: kXpressCompression supported: 0 2025-08-25T02:16:41.427024Z DEBUG main:start:open: conduwuit_database::engine::logger: kBZip2Compression supported: 1 2025-08-25T02:16:41.427039Z DEBUG main:start:open: conduwuit_database::engine::logger: kLZ4Compression supported: 1 2025-08-25T02:16:41.427054Z DEBUG main:start:open: conduwuit_database::engine::logger: kZlibCompression supported: 0 2025-08-25T02:16:41.427065Z DEBUG main:start:open: conduwuit_database::engine::logger: kLZ4HCCompression supported: 1 2025-08-25T02:16:41.427072Z DEBUG main:start:open: conduwuit_database::engine::logger: kSnappyCompression supported: 0 2025-08-25T02:16:41.427080Z DEBUG main:start:open: conduwuit_database::engine::logger: Fast CRC32 supported: Not supported on x86 2025-08-25T02:16:41.427086Z DEBUG main:start:open: conduwuit_database::engine::logger: DMutex implementation: pthread_mutex_t 2025-08-25T02:16:41.427093Z DEBUG main:start:open: conduwuit_database::engine::logger: Jemalloc supported: 1 2025-08-25T02:16:41.427306Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc96b4b50a0) cache_index_and_filter_blocks: 0 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 1 index_type: 0 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc96b4db190 block_cache_name: LRUCache block_cache_options: capacity : 33554432 num_shard_bits : 6 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 4096 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 4096 partition_filters: 0 use_delta_encoding: 1 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.427602Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc9716c10e0) cache_index_and_filter_blocks: 1 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 0 index_type: 2 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc971670110 block_cache_name: LRUCache block_cache_options: capacity : 603979776 num_shard_bits : 7 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 512 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 512 partition_filters: 1 use_delta_encoding: 0 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.427871Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc96b4b5d60) cache_index_and_filter_blocks: 1 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 0 index_type: 2 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc971670110 block_cache_name: LRUCache block_cache_options: capacity : 603979776 num_shard_bits : 7 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 512 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 512 partition_filters: 1 use_delta_encoding: 0 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.428142Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc96b4d2860) cache_index_and_filter_blocks: 1 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 0 index_type: 2 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc971670110 block_cache_name: LRUCache block_cache_options: capacity : 603979776 num_shard_bits : 7 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 512 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 512 partition_filters: 1 use_delta_encoding: 0 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.428400Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc96b4d2dc0) cache_index_and_filter_blocks: 1 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 0 index_type: 2 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc971670110 block_cache_name: LRUCache block_cache_options: capacity : 603979776 num_shard_bits : 7 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 512 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 512 partition_filters: 1 use_delta_encoding: 0 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.429172Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc96b4d3d40) cache_index_and_filter_blocks: 1 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 0 index_type: 2 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc971670110 block_cache_name: LRUCache block_cache_options: capacity : 603979776 num_shard_bits : 7 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 512 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 512 partition_filters: 1 use_delta_encoding: 0 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.429569Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc96b4df2e0) cache_index_and_filter_blocks: 1 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 0 index_type: 2 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc971670110 block_cache_name: LRUCache block_cache_options: capacity : 603979776 num_shard_bits : 7 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 512 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 512 partition_filters: 1 use_delta_encoding: 0 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.430006Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc96b4ca4e0) cache_index_and_filter_blocks: 1 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 0 index_type: 2 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc971670110 block_cache_name: LRUCache block_cache_options: capacity : 603979776 num_shard_bits : 7 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 512 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 512 partition_filters: 1 use_delta_encoding: 0 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.430329Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc96b4b56c0) cache_index_and_filter_blocks: 1 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 0 index_type: 2 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc971670110 block_cache_name: LRUCache block_cache_options: capacity : 603979776 num_shard_bits : 7 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 512 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 512 partition_filters: 1 use_delta_encoding: 0 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.430591Z DEBUG main:start:open: conduwuit_database::engine::logger: table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x7fc96b4d24a0) cache_index_and_filter_blocks: 1 cache_index_and_filter_blocks_with_high_priority: 1 pin_l0_filter_and_index_blocks_in_cache: 0 pin_top_level_index_and_filter: 0 index_type: 2 data_block_index_type: 0 index_shortening: 1 data_block_hash_table_util_ratio: 0.750000 checksum: 4 no_block_cache: 0 block_cache: 0x7fc971670050 block_cache_name: LRUCache block_cache_options: capacity : 399360000 num_shard_bits : 7 strict_capacity_limit : 0 memory_allocator : None high_pri_pool_ratio: 0.500 low_pri_pool_ratio: 0.000 persistent_cache: (nil) block_size: 1024 block_size_deviation: 10 block_restart_interval: 16 index_block_restart_interval: 1 metadata_block_size: 512 partition_filters: 1 use_delta_encoding: 0 filter_policy: nullptr whole_key_filtering: 1 verify_compression: 0 read_amp_bytes_per_bit: 0 format_version: 6 enable_index_compression: 1 block_align: 0 max_auto_readahead_size: 262144 prepopulate_block_cache: 0 initial_auto_readahead_size: 8192 num_file_reads_for_auto_readahead: 2 2025-08-25T02:16:41.532203Z DEBUG main:start:open: conduwuit_database::engine::logger: DB pointer 0x7fc96b5a8000 2025-08-25T02:16:41.532490Z INFO main:start:open: conduwuit_database::engine::open: Opened database. columns=89 sequence=14850 time=107.588862ms 2025-08-25T02:16:41.542574Z DEBUG main:start: conduwuit_service::server_keys::keypair: Found existing Ed25519 keypair: "apeQ87Re" 2025-08-25T02:16:41.542742Z INFO main:start: conduwuit_service::services: Starting services... 2025-08-25T02:16:41.543283Z DEBUG main:start: conduwuit_service::media::migrations: Checking integrity of media directory 2025-08-25T02:16:41.543414Z INFO main:start: conduwuit_service::media::migrations: Finished checking media directory elapsed=114.55µs 2025-08-25T02:16:41.543559Z INFO main:start: conduwuit_service::migrations: Loaded RocksDB database with schema version 17 2025-08-25T02:16:41.543587Z DEBUG main:start: conduwuit_service::manager: Starting service manager... 2025-08-25T02:16:41.543641Z DEBUG main:start: conduwuit_service::manager: Starting service workers... 2025-08-25T02:16:41.543652Z DEBUG main:start: conduwuit_service::manager: Service "account_data" worker starting... 2025-08-25T02:16:41.543684Z DEBUG main:start: conduwuit_service::manager: Service "admin" worker starting... 2025-08-25T02:16:41.543697Z DEBUG main:start: conduwuit_service::manager: Service "announcements" worker starting... 2025-08-25T02:16:41.543707Z DEBUG main:start: conduwuit_service::manager: Service "appservice" worker starting... 2025-08-25T02:16:41.543715Z DEBUG main:start: conduwuit_service::manager: Service "client" worker starting... 2025-08-25T02:16:41.543722Z DEBUG main:start: conduwuit_service::manager: Service "config" worker starting... 2025-08-25T02:16:41.543733Z DEBUG main:start: conduwuit_service::manager: Service "emergency" worker starting... 2025-08-25T02:16:41.543742Z DEBUG main:start: conduwuit_service::manager: Service "federation" worker starting... 2025-08-25T02:16:41.543775Z DEBUG main:start: conduwuit_service::manager: Service "globals" worker starting... 2025-08-25T02:16:41.543795Z DEBUG main:start: conduwuit_service::manager: Service "key_backups" worker starting... 2025-08-25T02:16:41.543802Z DEBUG main:start: conduwuit_service::manager: Service "media" worker starting... 2025-08-25T02:16:41.543808Z DEBUG main:start: conduwuit_service::manager: Service "moderation" worker starting... 2025-08-25T02:16:41.543815Z DEBUG main:start: conduwuit_service::manager: Service "presence" worker starting... 2025-08-25T02:16:41.543825Z DEBUG main:start: conduwuit_service::manager: Service "pusher" worker starting... 2025-08-25T02:16:41.543834Z DEBUG main:start: conduwuit_service::manager: Service "resolver" worker starting... 2025-08-25T02:16:41.543851Z DEBUG main:start: conduwuit_service::manager: Service "rooms::alias" worker starting... 2025-08-25T02:16:41.543860Z DEBUG main:start: conduwuit_service::manager: Service "rooms::auth_chain" worker starting... 2025-08-25T02:16:41.543866Z DEBUG main:start: conduwuit_service::manager: Service "rooms::directory" worker starting... 2025-08-25T02:16:41.543875Z DEBUG main:start: conduwuit_service::manager: Service "rooms::event_handler" worker starting... 2025-08-25T02:16:41.543884Z DEBUG main:start: conduwuit_service::manager: Service "rooms::lazy_loading" worker starting... 2025-08-25T02:16:41.543893Z DEBUG main:start: conduwuit_service::manager: Service "rooms::metadata" worker starting... 2025-08-25T02:16:41.543903Z DEBUG main:start: conduwuit_service::manager: Service "rooms::outlier" worker starting... 2025-08-25T02:16:41.543912Z DEBUG main:start: conduwuit_service::manager: Service "rooms::pdu_metadata" worker starting... 2025-08-25T02:16:41.543924Z DEBUG main:start: conduwuit_service::manager: Service "rooms::read_receipt" worker starting... 2025-08-25T02:16:41.543935Z DEBUG main:start: conduwuit_service::manager: Service "rooms::search" worker starting... 2025-08-25T02:16:41.543942Z DEBUG main:start: conduwuit_service::manager: Service "rooms::short" worker starting... 2025-08-25T02:16:41.543948Z DEBUG main:start: conduwuit_service::manager: Service "rooms::spaces" worker starting... 2025-08-25T02:16:41.543954Z DEBUG main:start: conduwuit_service::manager: Service "rooms::state" worker starting... 2025-08-25T02:16:41.543960Z DEBUG main:start: conduwuit_service::manager: Service "rooms::state_accessor" worker starting... 2025-08-25T02:16:41.543966Z DEBUG main:start: conduwuit_service::manager: Service "rooms::state_cache" worker starting... 2025-08-25T02:16:41.543971Z DEBUG main:start: conduwuit_service::manager: Service "rooms::state_compressor" worker starting... 2025-08-25T02:16:41.543977Z DEBUG main:start: conduwuit_service::manager: Service "rooms::threads" worker starting... 2025-08-25T02:16:41.543990Z DEBUG main:start: conduwuit_service::manager: Service "rooms::timeline" worker starting... 2025-08-25T02:16:41.543999Z DEBUG main:start: conduwuit_service::manager: Service "rooms::typing" worker starting... 2025-08-25T02:16:41.544007Z DEBUG main:start: conduwuit_service::manager: Service "rooms::user" worker starting... 2025-08-25T02:16:41.544013Z DEBUG main:start: conduwuit_service::manager: Service "sending" worker starting... 2025-08-25T02:16:41.544018Z DEBUG main:start: conduwuit_service::manager: Service "server_keys" worker starting... 2025-08-25T02:16:41.544024Z DEBUG main:start: conduwuit_service::manager: Service "sync" worker starting... 2025-08-25T02:16:41.544029Z DEBUG main:start: conduwuit_service::manager: Service "transaction_ids" worker starting... 2025-08-25T02:16:41.544035Z DEBUG main:start: conduwuit_service::manager: Service "uiaa" worker starting... 2025-08-25T02:16:41.544041Z DEBUG main:start: conduwuit_service::manager: Service "users" worker starting... 2025-08-25T02:16:41.544148Z DEBUG conduwuit_service::manager: service "account_data" worker finished 2025-08-25T02:16:41.544164Z DEBUG conduwuit_service::manager: service "client" worker finished 2025-08-25T02:16:41.544173Z DEBUG conduwuit_service::manager: service "appservice" worker finished 2025-08-25T02:16:41.544182Z DEBUG conduwuit_service::manager: service "federation" worker finished 2025-08-25T02:16:41.544190Z DEBUG conduwuit_service::manager: service "globals" worker finished 2025-08-25T02:16:41.544196Z DEBUG conduwuit_service::manager: service "key_backups" worker finished 2025-08-25T02:16:41.544203Z DEBUG conduwuit_service::manager: service "moderation" worker finished 2025-08-25T02:16:41.544212Z DEBUG conduwuit_service::manager: service "pusher" worker finished 2025-08-25T02:16:41.544220Z DEBUG conduwuit_service::manager: service "resolver" worker finished 2025-08-25T02:16:41.544227Z DEBUG conduwuit_service::manager: service "rooms::alias" worker finished 2025-08-25T02:16:41.544232Z DEBUG conduwuit_service::manager: service "rooms::auth_chain" worker finished 2025-08-25T02:16:41.544238Z DEBUG conduwuit_service::manager: service "rooms::directory" worker finished 2025-08-25T02:16:41.544246Z DEBUG conduwuit_service::manager: service "rooms::event_handler" worker finished 2025-08-25T02:16:41.544251Z DEBUG conduwuit_service::manager: service "rooms::lazy_loading" worker finished 2025-08-25T02:16:41.544257Z DEBUG conduwuit_service::manager: service "rooms::metadata" worker finished 2025-08-25T02:16:41.544265Z DEBUG conduwuit_service::manager: service "rooms::outlier" worker finished 2025-08-25T02:16:41.544273Z DEBUG conduwuit_service::manager: service "rooms::search" worker finished 2025-08-25T02:16:41.544282Z DEBUG conduwuit_service::manager: service "rooms::pdu_metadata" worker finished 2025-08-25T02:16:41.544288Z DEBUG conduwuit_service::manager: service "rooms::short" worker finished 2025-08-25T02:16:41.544293Z DEBUG conduwuit_service::manager: service "rooms::read_receipt" worker finished 2025-08-25T02:16:41.544300Z DEBUG conduwuit_service::manager: service "rooms::state_accessor" worker finished 2025-08-25T02:16:41.544308Z DEBUG conduwuit_service::manager: service "rooms::spaces" worker finished 2025-08-25T02:16:41.544315Z DEBUG conduwuit_service::manager: service "rooms::state_cache" worker finished 2025-08-25T02:16:41.544320Z DEBUG conduwuit_service::manager: service "rooms::state" worker finished 2025-08-25T02:16:41.544325Z DEBUG conduwuit_service::manager: service "rooms::state_compressor" worker finished 2025-08-25T02:16:41.544330Z DEBUG conduwuit_service::manager: service "rooms::threads" worker finished 2025-08-25T02:16:41.544334Z DEBUG conduwuit_service::manager: service "rooms::timeline" worker finished 2025-08-25T02:16:41.544339Z DEBUG conduwuit_service::manager: service "rooms::typing" worker finished 2025-08-25T02:16:41.544344Z DEBUG conduwuit_service::manager: service "rooms::user" worker finished 2025-08-25T02:16:41.544349Z DEBUG conduwuit_service::manager: service "server_keys" worker finished 2025-08-25T02:16:41.544354Z DEBUG conduwuit_service::manager: service "sync" worker finished 2025-08-25T02:16:41.544359Z DEBUG conduwuit_service::manager: service "transaction_ids" worker finished 2025-08-25T02:16:41.544363Z DEBUG conduwuit_service::manager: service "uiaa" worker finished 2025-08-25T02:16:41.544368Z DEBUG conduwuit_service::manager: service "users" worker finished 2025-08-25T02:16:41.544651Z DEBUG conduwuit_service::manager: service "emergency" worker finished 2025-08-25T02:16:41.544687Z DEBUG conduwuit_service::manager: service "media" worker finished 2025-08-25T02:16:41.545227Z INFO main:start: conduwuit_service::services: Services startup complete. 2025-08-25T02:16:41.545248Z DEBUG main:start: conduwuit_router::run: Started 2025-08-25T02:16:41.545279Z DEBUG main:run: conduwuit_router::run: Start 2025-08-25T02:16:41.545308Z DEBUG main:run: conduwuit_router::run: Running 2025-08-25T02:16:41.545918Z DEBUG conduwuit_service::presence: Adding timer 0: @nex:continuwuity.localhost:8448 timeout:1800s 2025-08-25T02:16:41.554605Z INFO conduwuit_router::serve::tls: Note: It is strongly recommended that you use a reverse proxy instead of running conduwuit directly with TLS. 2025-08-25T02:16:41.554621Z DEBUG conduwuit_router::serve::tls: Using direct TLS. Certificate path ./synapse.localhost+1.pem and certificate private key path ./synapse.localhost+1-key.pem 2025-08-25T02:16:41.555325Z WARN conduwuit_router::serve::tls: Listening on [127.0.0.1:8448, [::1]:8448] with TLS certificate ./synapse.localhost+1.pem and supporting plain text (HTTP) connections too (insecure!) 2025-08-25T02:16:44.328706Z DEBUG conduwuit_service::presence: Adding timer 1: @nex:continuwuity.localhost:8448 timeout:300s 2025-08-25T02:16:45.293934Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:get_verify_key{origin="synapse.localhost:8447" key_id="ed25519:a_tonT"}: conduwuit_service::server_keys::get: Found key in cache 2025-08-25T02:16:45.297772Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::server_keys::get: Keys required to verify event required={"synapse.localhost:8447": ["ed25519:a_tonT"]} 2025-08-25T02:16:45.297872Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:get_verify_key{origin="synapse.localhost:8447" key_id="ed25519:a_tonT"}: conduwuit_service::server_keys::get: Found key in cache 2025-08-25T02:16:45.300450Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::handle_outlier_pdu: Fetching auth events 2025-08-25T02:16:45.300679Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::handle_outlier_pdu: Checking based on auth events 2025-08-25T02:16:45.300858Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: auth_check beginning event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 event_type="m.room.power_levels" 2025-08-25T02:16:45.300932Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: privileging room creator or additional creator 2025-08-25T02:16:45.300971Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: permissions factors required_level=100 user_level=9007199254740991 state_key=Some("") power_level_event_id=Some("$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8") 2025-08-25T02:16:45.300989Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: starting m.room.power_levels check 2025-08-25T02:16:45.301015Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: validation of power event finished 2025-08-25T02:16:45.301035Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: user levels to check set={"@nex:continuwuity.localhost:8448"} 2025-08-25T02:16:45.301055Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: event levels to check set={"m.room.avatar", "m.room.canonical_alias", "m.room.encryption", "m.room.history_visibility", "m.room.name", "m.room.power_levels", "m.room.server_acl", "m.room.tombstone"} 2025-08-25T02:16:45.301103Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: m.room.power_levels event allowed 2025-08-25T02:16:45.301111Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: allowing event passed all checks 2025-08-25T02:16:45.301566Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:fetch_prev{origin=synapse.localhost:8447}:lexicographical_topological_sort: conduwuit_core::matrix::state_res: starting lexicographical topological sort 2025-08-25T02:16:45.301612Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::handle_incoming_pdu: Handling previous events events=["$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"] 2025-08-25T02:16:45.301738Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Upgrading PDU from outlier to timeline event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 2025-08-25T02:16:45.301754Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Resolving state at event event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 2025-08-25T02:16:45.302227Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:state: conduwuit_service::rooms::event_handler::state_at_incoming: Using cached state 2025-08-25T02:16:45.302365Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Performing auth check to upgrade event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 2025-08-25T02:16:45.302378Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Running initial auth check event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 2025-08-25T02:16:45.302396Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: auth_check beginning event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 event_type="m.room.power_levels" 2025-08-25T02:16:45.302603Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: privileging room creator or additional creator 2025-08-25T02:16:45.302628Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: permissions factors required_level=100 user_level=9007199254740991 state_key=Some("") power_level_event_id=Some("$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8") 2025-08-25T02:16:45.302638Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: starting m.room.power_levels check 2025-08-25T02:16:45.302653Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: validation of power event finished 2025-08-25T02:16:45.302668Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: user levels to check set={"@nex:continuwuity.localhost:8448"} 2025-08-25T02:16:45.302680Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: event levels to check set={"m.room.avatar", "m.room.canonical_alias", "m.room.encryption", "m.room.history_visibility", "m.room.name", "m.room.power_levels", "m.room.server_acl", "m.room.tombstone"} 2025-08-25T02:16:45.302718Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: m.room.power_levels event allowed 2025-08-25T02:16:45.302725Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: allowing event passed all checks 2025-08-25T02:16:45.302741Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Gathering auth events event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 2025-08-25T02:16:45.302770Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::state: Auth types for event auth_types=[("m.room.power_levels", ""), ("m.room.member", "@nex:synapse.localhost:8447")] 2025-08-25T02:16:45.302855Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::state: Auth events to fetch sauthevents={17: ("m.room.power_levels", ""), 221: ("m.room.member", "@nex:synapse.localhost:8447")} 2025-08-25T02:16:45.302927Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::state: Auth events found in state state_keys=[("m.room.member", "@nex:synapse.localhost:8447")] event_ids=[1510] 2025-08-25T02:16:45.303157Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Running auth check with claimed state auth event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 2025-08-25T02:16:45.303177Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: auth_check beginning event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 event_type="m.room.power_levels" 2025-08-25T02:16:45.303207Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: privileging room creator or additional creator 2025-08-25T02:16:45.303216Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: permissions factors required_level=50 user_level=9007199254740991 state_key=Some("") power_level_event_id=None 2025-08-25T02:16:45.303225Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: starting m.room.power_levels check 2025-08-25T02:16:45.303242Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: validation of power event finished 2025-08-25T02:16:45.303249Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: m.room.power_levels event allowed 2025-08-25T02:16:45.303255Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: allowing event passed all checks 2025-08-25T02:16:45.303268Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Performing soft-fail check event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 2025-08-25T02:16:45.303518Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Retained 0 extremities checked against 1 prev_events 2025-08-25T02:16:45.303742Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Event is a state-event. Deriving new room state 2025-08-25T02:16:45.304305Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:auth_chain: conduwuit_service::rooms::auth_chain: start starting_events=7 elapsed=184.93µs 2025-08-25T02:16:45.304578Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:auth_chain: conduwuit_service::rooms::auth_chain: done chain_length=4 elapsed=459.03µs 2025-08-25T02:16:45.304758Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:auth_chain: conduwuit_service::rooms::auth_chain: start starting_events=8 elapsed=564.53µs 2025-08-25T02:16:45.305820Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:auth_chain: conduwuit_service::rooms::auth_chain: Cache missed event event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0" elapsed=1.626551ms 2025-08-25T02:16:45.305870Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:auth_chain: conduwuit_service::rooms::auth_chain: Cache missed chunk chunk_cache_length=4 elapsed=1.678231ms 2025-08-25T02:16:45.305894Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:auth_chain: conduwuit_service::rooms::auth_chain: done chain_length=6 elapsed=1.703211ms 2025-08-25T02:16:45.306102Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: State resolution starting 2025-08-25T02:16:45.306149Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: non-conflicting events count=7 2025-08-25T02:16:45.306158Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: non-conflicting events map={("m.room.name", ""): "$s2vVBtEZa4Co45a64BUPJy-mxpD-gqQWJnBV9WFj-6Q", ("m.room.create", ""): "$Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY", ("m.room.join_rules", ""): "$Qw1LIs-lvG13q4kJ9bYU0N6jLPVasT79cLGCSzKcwG0", ("m.room.member", "@nex:continuwuity.localhost:8448"): "$e85I8nakOd1cqR_HJzwEEo1BzP8cUQQIVQyKFI9Ez8M", ("m.room.history_visibility", ""): "$uwWZd_PlBPN60q4ezKmuupFlQrgsf1Uy0P-v9TmxPCg", ("m.room.guest_access", ""): "$XXF8Iq2XZrGAg5rag1X9bgB53-qrCW5w-ia_uHOzz7A", ("m.room.member", "@nex:synapse.localhost:8447"): "$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s"} 2025-08-25T02:16:45.306169Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: conflicting events count=1 2025-08-25T02:16:45.306176Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: conflicting events map={("m.room.power_levels", ""): ["$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"]} 2025-08-25T02:16:45.306586Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: conflicted subgraph count=0 2025-08-25T02:16:45.306615Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: conflicted subgraph set={} 2025-08-25T02:16:45.306765Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: full conflicted set count=3 2025-08-25T02:16:45.306778Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: full conflicted set set={"$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y", "$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8", "$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"} 2025-08-25T02:16:45.307075Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:reverse_topological_power_sort: conduwuit_core::matrix::state_res: reverse topological sort of power events 2025-08-25T02:16:45.307340Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:reverse_topological_power_sort: conduwuit_core::matrix::state_res: fetch event ($ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y) senders power level 2025-08-25T02:16:45.307579Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:reverse_topological_power_sort: conduwuit_core::matrix::state_res: found the power level of an event's sender event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y" power_level=0 2025-08-25T02:16:45.307602Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:reverse_topological_power_sort: conduwuit_core::matrix::state_res: fetch event ($m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0) senders power level 2025-08-25T02:16:45.307781Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:reverse_topological_power_sort: conduwuit_core::matrix::state_res: found the power level of an event's sender event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0" power_level=0 2025-08-25T02:16:45.307802Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:reverse_topological_power_sort: conduwuit_core::matrix::state_res: fetch event ($WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8) senders power level 2025-08-25T02:16:45.308001Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:reverse_topological_power_sort: conduwuit_core::matrix::state_res: found the power level of an event's sender event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8" power_level=0 2025-08-25T02:16:45.308032Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:reverse_topological_power_sort:lexicographical_topological_sort: conduwuit_core::matrix::state_res: starting lexicographical topological sort 2025-08-25T02:16:45.308299Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: power events count=3 2025-08-25T02:16:45.308312Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: sorted power events list=["$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y", "$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8", "$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"] 2025-08-25T02:16:45.308330Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: starting iterative auth check 2025-08-25T02:16:45.308646Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: events to check list=[Pdu { event_id: "$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y", room_id: Some("!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY"), sender: "@nex:synapse.localhost:8447", origin: None, origin_server_ts: 1756087395054, kind: "m.room.power_levels", content: RawValue({"ban":50,"events":{"m.room.avatar":50,"m.room.canonical_alias":50,"m.room.encryption":100,"m.room.history_visibility":100,"m.room.name":50,"m.room.power_levels":100,"m.room.server_acl":100,"m.room.tombstone":150},"events_default":0,"historical":100,"invite":0,"kick":50,"redact":50,"state_default":50,"users":{"@nex:continuwuity.localhost:8448":50},"users_default":0}), state_key: Some(""), prev_events: ["$34HosSprz44uObvTkWdsnyOocMIos5XlZQdJxt6wwbo"], depth: 12, auth_events: ["$5CMNXRKyiitOwJ7IodmuDGNVYbUgwHmRFLGMncTMKTM", "$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s"], redacts: None, unsigned: Some(RawValue({"prev_content":{"ban":50,"events":{"m.room.avatar":50,"m.room.canonical_alias":50,"m.room.encryption":100,"m.room.history_visibility":100,"m.room.name":50,"m.room.power_levels":100,"m.room.server_acl":100,"m.room.tombstone":150},"events_default":0,"historical":100,"invite":0,"kick":50,"redact":50,"state_default":50,"users":{},"users_default":0},"prev_sender":"@nex:synapse.localhost:8447","replaces_state":"$5CMNXRKyiitOwJ7IodmuDGNVYbUgwHmRFLGMncTMKTM"})), hashes: EventHash { sha256: "o4vDko/kwnUDILUpMLoZ+eJNeS0aguZcLVtoZwgqKiE" }, signatures: Some(RawValue({"synapse.localhost:8447":{"ed25519:a_tonT":"bBuNs0PY5rP7GgHNs0/JlXceRAdsEhpuiOfhnruaCthggix5iRg9vzYuRyZC6wl5pOxdIz1Eheee516q6FUnCg"}})) }, Pdu { event_id: "$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8", room_id: Some("!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY"), sender: "@nex:synapse.localhost:8447", origin: None, origin_server_ts: 1756088189619, kind: "m.room.power_levels", content: RawValue({"ban":50,"events":{"m.room.avatar":50,"m.room.canonical_alias":50,"m.room.encryption":100,"m.room.history_visibility":100,"m.room.name":50,"m.room.power_levels":100,"m.room.server_acl":100,"m.room.tombstone":150},"events_default":0,"historical":100,"invite":0,"kick":50,"redact":50,"state_default":50,"users":{"@nex:continuwuity.localhost:8448":100},"users_default":0}), state_key: Some(""), prev_events: ["$cQPQguwrDaktUr9cPYALci1Q8OW7wIkdF1hx_2pH9uk"], depth: 15, auth_events: ["$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y", "$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s"], redacts: None, unsigned: Some(RawValue({})), hashes: EventHash { sha256: "44S0FGZtVi3bY/ubG5bn94wloWxDNJySZbFNXTq6U2E" }, signatures: Some(RawValue({"synapse.localhost:8447":{"ed25519:a_tonT":"7x9b/tr7lsseOr23JjyhXNb/V0ro7FkW8EeAiIQehlxgXw1mIHEDw54jZ74v0Vdnm71TdI98yj+1WXmcRtEgDg"}})) }, Pdu { event_id: "$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0", room_id: Some("!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY"), sender: "@nex:synapse.localhost:8447", origin: None, origin_server_ts: 1756088205248, kind: "m.room.power_levels", content: RawValue({"ban":50,"events":{"m.room.avatar":50,"m.room.canonical_alias":50,"m.room.encryption":100,"m.room.history_visibility":100,"m.room.name":50,"m.room.power_levels":100,"m.room.server_acl":100,"m.room.tombstone":150},"events_default":0,"historical":100,"invite":0,"kick":50,"redact":50,"state_default":50,"users":{"@nex:continuwuity.localhost:8448":0},"users_default":0}), state_key: Some(""), prev_events: ["$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"], depth: 16, auth_events: ["$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8", "$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s"], redacts: None, unsigned: None, hashes: EventHash { sha256: "qxW1j5Vv5NhBSqXKQF5J0Bvb6f3m7mui4auuw2PRy14" }, signatures: Some(RawValue({"synapse.localhost:8447":{"ed25519:a_tonT":"cAH4b+DOdE6If2aeH0L4at63Gpm2b/9EmdnFgfu+6mu1DpRj1Vbd7EoWGM6GdyGjPFx7HOg2taArU+y4LWv7Bg"}})) }] 2025-08-25T02:16:45.308692Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: auth event IDs to fetch set={"$5CMNXRKyiitOwJ7IodmuDGNVYbUgwHmRFLGMncTMKTM", "$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y", "$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8", "$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s"} 2025-08-25T02:16:45.309035Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: fetched auth events map=["$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s", "$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y", "$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8", "$5CMNXRKyiitOwJ7IodmuDGNVYbUgwHmRFLGMncTMKTM"] 2025-08-25T02:16:45.309052Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: checking event event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y" 2025-08-25T02:16:45.309063Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: auth types for event list=[("m.room.power_levels", ""), ("m.room.member", "@nex:synapse.localhost:8447")] event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y" 2025-08-25T02:16:45.309073Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: room version uses hashed IDs, manually fetching create event 2025-08-25T02:16:45.309148Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: found auth event event_id="$5CMNXRKyiitOwJ7IodmuDGNVYbUgwHmRFLGMncTMKTM" 2025-08-25T02:16:45.309165Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: found auth event event_id="$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s" 2025-08-25T02:16:45.309184Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: auth state for event map=[("m.room.power_levels", ""), ("m.room.create", ""), ("m.room.member", "@nex:synapse.localhost:8447")] event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y" 2025-08-25T02:16:45.309194Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: Running auth checks event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y" 2025-08-25T02:16:45.309230Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"}: conduwuit_core::matrix::state_res::event_auth: auth_check beginning event_id=$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y event_type="m.room.power_levels" 2025-08-25T02:16:45.309280Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"}: conduwuit_core::matrix::state_res::event_auth: privileging room creator or additional creator 2025-08-25T02:16:45.309309Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"}: conduwuit_core::matrix::state_res::event_auth: permissions factors required_level=100 user_level=9007199254740991 state_key=Some("") power_level_event_id=Some("$5CMNXRKyiitOwJ7IodmuDGNVYbUgwHmRFLGMncTMKTM") 2025-08-25T02:16:45.309321Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"}: conduwuit_core::matrix::state_res::event_auth: starting m.room.power_levels check 2025-08-25T02:16:45.309344Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"}: conduwuit_core::matrix::state_res::event_auth: validation of power event finished 2025-08-25T02:16:45.309362Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"}: conduwuit_core::matrix::state_res::event_auth: user levels to check set={"@nex:continuwuity.localhost:8448"} 2025-08-25T02:16:45.309381Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"}: conduwuit_core::matrix::state_res::event_auth: event levels to check set={"m.room.avatar", "m.room.canonical_alias", "m.room.encryption", "m.room.history_visibility", "m.room.name", "m.room.power_levels", "m.room.server_acl", "m.room.tombstone"} 2025-08-25T02:16:45.309430Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"}: conduwuit_core::matrix::state_res::event_auth: m.room.power_levels event allowed 2025-08-25T02:16:45.309438Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"}: conduwuit_core::matrix::state_res::event_auth: allowing event passed all checks 2025-08-25T02:16:45.309455Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: event passed the authentication check, adding to resolved state event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y" 2025-08-25T02:16:45.309467Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: new resolved state map={("m.room.power_levels", ""): "$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y"} 2025-08-25T02:16:45.309479Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: checking event event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8" 2025-08-25T02:16:45.309487Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: auth types for event list=[("m.room.power_levels", ""), ("m.room.member", "@nex:synapse.localhost:8447")] event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8" 2025-08-25T02:16:45.309495Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: room version uses hashed IDs, manually fetching create event 2025-08-25T02:16:45.309567Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: found auth event event_id="$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y" 2025-08-25T02:16:45.309583Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: found auth event event_id="$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s" 2025-08-25T02:16:45.309606Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: auth state for event map=[("m.room.member", "@nex:synapse.localhost:8447"), ("m.room.create", ""), ("m.room.power_levels", "")] event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8" 2025-08-25T02:16:45.309616Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: Running auth checks event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8" 2025-08-25T02:16:45.309633Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"}: conduwuit_core::matrix::state_res::event_auth: auth_check beginning event_id=$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8 event_type="m.room.power_levels" 2025-08-25T02:16:45.309667Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"}: conduwuit_core::matrix::state_res::event_auth: privileging room creator or additional creator 2025-08-25T02:16:45.309686Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"}: conduwuit_core::matrix::state_res::event_auth: permissions factors required_level=100 user_level=9007199254740991 state_key=Some("") power_level_event_id=Some("$ddDXae2IoMw9HuyIxlGRzE04Co6BOKZTrFTAjtjMH4Y") 2025-08-25T02:16:45.309696Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"}: conduwuit_core::matrix::state_res::event_auth: starting m.room.power_levels check 2025-08-25T02:16:45.309712Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"}: conduwuit_core::matrix::state_res::event_auth: validation of power event finished 2025-08-25T02:16:45.309730Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"}: conduwuit_core::matrix::state_res::event_auth: user levels to check set={"@nex:continuwuity.localhost:8448"} 2025-08-25T02:16:45.309744Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"}: conduwuit_core::matrix::state_res::event_auth: event levels to check set={"m.room.avatar", "m.room.canonical_alias", "m.room.encryption", "m.room.history_visibility", "m.room.name", "m.room.power_levels", "m.room.server_acl", "m.room.tombstone"} 2025-08-25T02:16:45.309780Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"}: conduwuit_core::matrix::state_res::event_auth: m.room.power_levels event allowed 2025-08-25T02:16:45.309788Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"}: conduwuit_core::matrix::state_res::event_auth: allowing event passed all checks 2025-08-25T02:16:45.309803Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: event passed the authentication check, adding to resolved state event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8" 2025-08-25T02:16:45.309814Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: new resolved state map={("m.room.power_levels", ""): "$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8"} 2025-08-25T02:16:45.309825Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: checking event event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0" 2025-08-25T02:16:45.309833Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: auth types for event list=[("m.room.power_levels", ""), ("m.room.member", "@nex:synapse.localhost:8447")] event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0" 2025-08-25T02:16:45.309849Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: room version uses hashed IDs, manually fetching create event 2025-08-25T02:16:45.309922Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: found auth event event_id="$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8" 2025-08-25T02:16:45.309938Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: found auth event event_id="$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s" 2025-08-25T02:16:45.309958Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: auth state for event map=[("m.room.member", "@nex:synapse.localhost:8447"), ("m.room.create", ""), ("m.room.power_levels", "")] event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0" 2025-08-25T02:16:45.309968Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: Running auth checks event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0" 2025-08-25T02:16:45.309984Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: auth_check beginning event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 event_type="m.room.power_levels" 2025-08-25T02:16:45.310016Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: privileging room creator or additional creator 2025-08-25T02:16:45.310035Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: permissions factors required_level=100 user_level=9007199254740991 state_key=Some("") power_level_event_id=Some("$WoWIniRtdUwM_jz5uvUpkkTCRdmzwDNMm5iccRdSoI8") 2025-08-25T02:16:45.310044Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: starting m.room.power_levels check 2025-08-25T02:16:45.310058Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: validation of power event finished 2025-08-25T02:16:45.310072Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: user levels to check set={"@nex:continuwuity.localhost:8448"} 2025-08-25T02:16:45.310085Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: event levels to check set={"m.room.avatar", "m.room.canonical_alias", "m.room.encryption", "m.room.history_visibility", "m.room.name", "m.room.power_levels", "m.room.server_acl", "m.room.tombstone"} 2025-08-25T02:16:45.310117Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: m.room.power_levels event allowed 2025-08-25T02:16:45.310125Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check:auth_check{event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"}: conduwuit_core::matrix::state_res::event_auth: allowing event passed all checks 2025-08-25T02:16:45.310139Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: event passed the authentication check, adding to resolved state event_id="$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0" 2025-08-25T02:16:45.310150Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: new resolved state map={("m.room.power_levels", ""): "$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"} 2025-08-25T02:16:45.310163Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: final resolved state from iterative auth check map={("m.room.power_levels", ""): "$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"} 2025-08-25T02:16:45.310170Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: iterative auth check finished 2025-08-25T02:16:45.310187Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: resolved power events count=1 2025-08-25T02:16:45.310195Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: resolved power events map={("m.room.power_levels", ""): "$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0"} 2025-08-25T02:16:45.310210Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: events left to resolve count=0 2025-08-25T02:16:45.310217Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: events left to resolve list=[] 2025-08-25T02:16:45.310225Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: power event event_id=Some("$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0") 2025-08-25T02:16:45.310234Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: mainline sort of events 2025-08-25T02:16:45.310240Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: events left, sorted list=[] 2025-08-25T02:16:45.310252Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: starting iterative auth check 2025-08-25T02:16:45.310268Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: events to check list=[] 2025-08-25T02:16:45.310277Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: auth event IDs to fetch set={} 2025-08-25T02:16:45.310293Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: fetched auth events map=[] 2025-08-25T02:16:45.310302Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: final resolved state from iterative auth check map={} 2025-08-25T02:16:45.310308Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma:iterative_auth_check: conduwuit_core::matrix::state_res: iterative auth check finished 2025-08-25T02:16:45.310326Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: state resolution finished 2025-08-25T02:16:45.310333Z TRACE router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}:resolve:ruma: conduwuit_core::matrix::state_res: final resolved state map={("m.room.name", ""): "$s2vVBtEZa4Co45a64BUPJy-mxpD-gqQWJnBV9WFj-6Q", ("m.room.member", "@nex:continuwuity.localhost:8448"): "$e85I8nakOd1cqR_HJzwEEo1BzP8cUQQIVQyKFI9Ez8M", ("m.room.join_rules", ""): "$Qw1LIs-lvG13q4kJ9bYU0N6jLPVasT79cLGCSzKcwG0", ("m.room.create", ""): "$Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY", ("m.room.history_visibility", ""): "$uwWZd_PlBPN60q4ezKmuupFlQrgsf1Uy0P-v9TmxPCg", ("m.room.guest_access", ""): "$XXF8Iq2XZrGAg5rag1X9bgB53-qrCW5w-ia_uHOzz7A", ("m.room.member", "@nex:synapse.localhost:8447"): "$3mNqeuIqSONAFfqsE2YDIjijmo1UjgFkHmB-oR5qz9s"} 2025-08-25T02:16:45.310710Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Forcing new room state 2025-08-25T02:16:45.315455Z INFO router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}:pdu{room_id=!Ejau1BoYfQSr_DnngT0Rg0uZOe5XPSF4iYQAz70d5ZY event_id=$m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0}: conduwuit_service::rooms::event_handler::upgrade_outlier_pdu: Accepted elapsed=13.701345ms 2025-08-25T02:16:45.315507Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}: conduwuit_api::server::send: Finished PDU $m0v4DZUFd64BApfk4OG77LEACE52n2dCTEwxfzOI2F0 pdu_elapsed=18.146937ms txn_elapsed=18.748917ms 2025-08-25T02:16:45.315589Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=4}:txn{client=127.0.0.1 origin="synapse.localhost:8447"}: conduwuit_api::server::send: Finished txn pdus=1 edus=0 elapsed=18.829317ms id="1756068525310" origin="synapse.localhost:8447"