--------------------------------- Captured Out --------------------------------- ---- new test ---- 1773600057.414 sable_ircd uid=1001 1773600057.414 sable_services uid=1001 1773600057.415 sable_services #x1B[2m2026-03-15T18:40:57.415126Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.History"), address: "127.0.0.1:42477", fingerprint: "47e4b52620e9fc4a2b07209510d27751a5fbf4fc" } 1773600057.415 sable_services #x1B[2m2026-03-15T18:40:57.415392Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:42477. Last error: I/O error: Connection refused (os error 111) 1773600057.416 sable_services #x1B[2m2026-03-15T18:40:57.415454Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1773600057.418 sable_ircd #x1B[2m2026-03-15T18:40:57.417681Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090613637156864)), timestamp: 1773600057, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Server"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.417812Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.417948Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from reap_preclients_timer 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.418156Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m#x1B[1mapply_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mevent#x1B[0m#x1B[2m=#x1B[0mEvent { id: EventId(Snowflake(821090613637156864)), timestamp: 1773600057, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Server"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_server#x1B[0m#x1B[1m{#x1B[0m#x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mNewServer { server: ServerId(1) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Server 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.418341Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090613641351169)), timestamp: 1773600057, clock: EventClock(1 => 821090613637156864), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1773600057 }) }; event clock=EventClock(1 => 821090613637156864) my clock=EventClock(1 => 821090613637156864) 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.418404Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.418668Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090613637156864)), timestamp: 1773600057, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.418721Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090613637156864)), timestamp: 1773600057, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.418800Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090613637156864)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.418839Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090613637156864)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] } 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.418887Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090613641351169)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600057.419 sable_ircd #x1B[2m2026-03-15T18:40:57.418913Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090613641351169)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] } 1773600057.425 sable_history #x1B[2m2027-03-15T19:27:40.441328Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(953373941311938613)), timestamp: 1805138860, clock: EventClock(1 => 953361345594527745, 50 => 953373689653698612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1805138860 }) }; event clock=EventClock(1 => 953361345594527745, 50 => 953373689653698612) my clock=EventClock(1 => 953361345594527745, 50 => 953373689653698612) 1773600057.425 sable_history #x1B[2m2027-03-15T19:27:40.443491Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1773600057.479 sable_services #x1B[2m2026-03-15T18:40:57.478909Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.Server"), address: "127.0.0.1:45553", fingerprint: "3e2017c272526b468b201d029faa51241b13004f" } 1773600057.479 sable_services #x1B[2m2026-03-15T18:40:57.479291Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600057.484 sable_ircd #x1B[2m2026-03-15T18:40:57.484243Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::node#x1B[0m#x1B[2m:#x1B[0m Server got state export request; sending 1773600057.511 sable_ircd #x1B[2m2026-03-15T18:40:57.510438Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 1), remote_addr: 127.0.0.1, tls_info: None } 1773600057.511 sable_ircd #x1B[2m2026-03-15T18:40:57.510646Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.511 sable_ircd #x1B[2m2026-03-15T18:40:57.510708Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1773600057.511 sable_ircd #x1B[2m2026-03-15T18:40:57.510798Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 1): :My.Little.Server NOTICE * :*** Looking up your hostname 1773600057.511 sable_ircd #x1B[2m2026-03-15T18:40:57.510987Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.511 sable_ircd #x1B[2m2026-03-15T18:40:57.511055Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"QUIT :chkport" 1773600057.511 sable_ircd #x1B[2m2026-03-15T18:40:57.511189Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 1): ERROR :Client quit 1773600057.511 sable_ircd #x1B[2m2026-03-15T18:40:57.511287Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mCloseConnection(ConnectionId(ListenerId(0), 1)) 1773600057.511 sable_ircd #x1B[2m2026-03-15T18:40:57.511330Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::connection_collection#x1B[0m#x1B[2m:#x1B[0m Removing connection ConnectionId(ListenerId(0), 1) 1773600057.512 sable_ircd #x1B[2m2026-03-15T18:40:57.511864Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m Connection error #x1B[3mconnection#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed 1773600057.512 sable_ircd #x1B[2m2026-03-15T18:40:57.511981Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.512 sable_ircd #x1B[2m2026-03-15T18:40:57.512202Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events 1773600057.527 sable_services #x1B[2m2026-03-15T18:40:57.526352Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Bootstrap message: Message { source_server: (ServerId(1), 1773600057), content: NetworkState(Network { nick_bindings: {}, historic_nick_users: HistoricNickStore { data: {} }, users: {}, historic_users: HistoricUserStore { users: {} }, user_connections: {}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1773600057, name: ServerName("My.Little.Server"), last_ping: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }}, network_bans: BanRepository { pre_registration_bans: {}, new_connection_bans: {}, pre_sasl_bans: {}, pre_registration_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: ["", "", "", "", "", ""], uint64: [], regex: [] }, fields: {"host": (3, String(_)), "user_param_2": (5, String(_)), "ip": (0, Ip(_)), "nick": (2, String(_)), "realname": (4, String(_)), "user": (0, String(_)), "user_param_1": (1, String(_)), "tls": (0, Boolean(_))} }, new_connection_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [], uint64: [], regex: [] }, fields: {"tls": (0, Boolean(_)), "ip": (0, Ip(_))} }, pre_sasl_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [""], uint64: [], regex: [] }, fields: {"mechanism": (0, String(_)), "ip": (0, Ip(_)), "tls": (0, Boolean(_))} } }, audit_log: {}, accounts: {}, nick_registrations: {}, channel_registrations: {}, channel_accesses: {}, channel_roles: {}, current_services: None, current_history_server_id: None, config: NetworkConfig { opers: [OperConfig { name: "operuser", hash: "$6$z5yA.OfGliDoi/R2$BgSsguS6bxAsPSCygDisgDw5JZuo5.88eU3Hyc7/4OaNpeKIxWGjOggeHzOl0xLiZg1vfwxXjOTFN14wG5vNI." }], debug_mode: true, default_roles: {BuiltinOp: ChannelAccessSet(222192934775), BuiltinAll: ChannelAccessSet(1114112), BuiltinVoice: ChannelAccessSet(4296081441)}, alias_users: [AliasUser { nick: Nickname("ChanServ"), user: Username("ChanServ"), host: Hostname("services."), realname: Realname("Channel services compatibility layer"), command_alias: "CS" }, AliasUser { nick: Nickname("NickServ"), user: Username("NickServ"), host: Hostname("services."), realname: Realname("Account services compatibility layer"), command_alias: "NS" }], object_expiry: 60, pingout_duration: 600 }, clock: EventClock(1 => 821090613641351169), cache_default_channel_roles: OnceLock(), alias_users: OnceLock() }) } 1773600057.527 sable_services #x1B[2m2026-03-15T18:40:57.526564Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Server 1773600057.527 sable_services #x1B[2m2026-03-15T18:40:57.526683Z#x1B[0m #x1B[33m WARN#x1B[0m #x1B[2msable_services::database::jsonfile#x1B[0m#x1B[2m:#x1B[0m Couldn't open database file, starting from empty 1773600057.527 sable_services #x1B[2m2026-03-15T18:40:57.527184Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Services"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 821090613641351169) my clock=EventClock(1 => 821090613641351169) 1773600057.528 sable_services #x1B[2m2026-03-15T18:40:57.527622Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Services"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600057.530 sable_services #x1B[2m2026-03-15T18:40:57.529606Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090614107320321)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614098931712), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1773600057 }) }; event clock=EventClock(1 => 821090613641351169, 99 => 821090614098931712) my clock=EventClock(1 => 821090613641351169, 99 => 821090614098931712) 1773600057.530 sable_services #x1B[2m2026-03-15T18:40:57.529981Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m#x1B[1mapply_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mevent#x1B[0m#x1B[2m=#x1B[0mEvent { id: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Services"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_server#x1B[0m#x1B[1m{#x1B[0m#x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mNewServer { server: ServerId(99) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Services 1773600057.530 sable_services #x1B[2m2026-03-15T18:40:57.529978Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614107320321)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614098931712), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1773600057 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600057.532 chkSvs: connects to server. 1773600057.532 chkSvs -> S: NICK chkSvs 1773600057.532 chkSvs -> S: USER chk chk chk chk 1773600057.532 sable_ircd #x1B[2m2026-03-15T18:40:57.532226Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 2), remote_addr: 127.0.0.1, tls_info: None } 1773600057.532 sable_ircd #x1B[2m2026-03-15T18:40:57.532382Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.532 sable_ircd #x1B[2m2026-03-15T18:40:57.532430Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1773600057.533 sable_ircd #x1B[2m2026-03-15T18:40:57.532502Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE * :*** Looking up your hostname 1773600057.533 sable_ircd #x1B[2m2026-03-15T18:40:57.532679Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.533 sable_ircd #x1B[2m2026-03-15T18:40:57.532736Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK chkSvs" 1773600057.533 sable_ircd #x1B[2m2026-03-15T18:40:57.532925Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 509, tv_nsec: 211938428 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1773600057.533 sable_ircd #x1B[2m2026-03-15T18:40:57.533001Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers 1773600057.533 sable_ircd #x1B[2m2026-03-15T18:40:57.533050Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.533 sable_ircd #x1B[2m2026-03-15T18:40:57.533097Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER chk chk chk chk" 1773600057.533 sable_ircd #x1B[2m2026-03-15T18:40:57.533197Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 509, tv_nsec: 211938428 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1773600057.534 sable_ircd #x1B[2m2026-03-15T18:40:57.533845Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events 1773600057.534 sable_ircd #x1B[2m2026-03-15T18:40:57.533895Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 2): 127.0.0.1/Some(Hostname("localhost")) 1773600057.534 sable_ircd #x1B[2m2026-03-15T18:40:57.533949Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE * :*** Found your hostname: localhost 1773600057.534 sable_ircd #x1B[2m2026-03-15T18:40:57.533994Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 509, tv_nsec: 211938428 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1773600057.534 sable_ircd #x1B[2m2026-03-15T18:40:57.534066Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mRegisterClient(ConnectionId(ListenerId(0), 2)) 1773600057.534 sable_services #x1B[2m2026-03-15T18:40:57.534236Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614107320321), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 821090613641351169, 99 => 821090614107320321) my clock=EventClock(1 => 821090613641351169, 99 => 821090614107320321) 1773600057.535 sable_ircd #x1B[2m2026-03-15T18:40:57.534411Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }; event clock=EventClock(1 => 821090613641351169) my clock=EventClock(1 => 821090613641351169) 1773600057.535 sable_ircd #x1B[2m2026-03-15T18:40:57.534562Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1773600057.535 sable_ircd #x1B[2m2026-03-15T18:40:57.534897Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(821090614127890432)), 1) }), users_to_notify: [] }) 1773600057.535 sable_ircd #x1B[2m2026-03-15T18:40:57.534956Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(821090614127890432)), 1) }), users_to_notify: [] } 1773600057.535 sable_ircd #x1B[2m2026-03-15T18:40:57.535035Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(821090614127890432)), 2), connection: UserConnectionId(Snowflake(821090614127890433)) }), users_to_notify: [] }) 1773600057.535 sable_ircd #x1B[2m2026-03-15T18:40:57.535068Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(821090614127890432)), 2), connection: UserConnectionId(Snowflake(821090614127890433)) }), users_to_notify: [] } 1773600057.535 sable_ircd #x1B[2m2026-03-15T18:40:57.535139Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1773600057.535 sable_services #x1B[2m2026-03-15T18:40:57.534946Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614107320321), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535189Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535231Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 003 chkSvs :This server was created 2026-03-15 18:40:57.535217436 UTC 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535262Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535314Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 005 chkSvs EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535351Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 422 chkSvs :MOTD File is missing 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535384Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :chkSvs!chk@localhost MODE chkSvs + 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535419Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535480Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535519Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] } 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535768Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614107320321)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614098931712), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1773600057 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(821090614107320321)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614098931712), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1773600057 }) }; event clock=EventClock(1 => 821090613641351169, 99 => 821090614098931712) my clock=EventClock(1 => 821090614127890434) 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535869Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614107320321)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614098931712), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1773600057 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(821090613641351169)), EventId(Snowflake(821090614098931712))] 1773600057.536 sable_ircd #x1B[2m2026-03-15T18:40:57.535922Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614107320321)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614098931712), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1773600057 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1773600057.571 sable_ircd #x1B[2m2026-03-15T18:40:57.571103Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Services"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Services"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 821090613641351169) my clock=EventClock(1 => 821090614127890434) 1773600057.571 sable_ircd #x1B[2m2026-03-15T18:40:57.571224Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Services"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(821090614107320321)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614098931712), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1773600057 }) } 1773600057.571 sable_ircd #x1B[2m2026-03-15T18:40:57.571329Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Services"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1773600057.572 sable_ircd #x1B[2m2026-03-15T18:40:57.571677Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m#x1B[1mapply_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mevent#x1B[0m#x1B[2m=#x1B[0mEvent { id: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1773600057, name: ServerName("My.Little.Services"), ts: 1773600057, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_server#x1B[0m#x1B[1m{#x1B[0m#x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mNewServer { server: ServerId(99) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Services 1773600057.572 sable_ircd #x1B[2m2026-03-15T18:40:57.571883Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }) 1773600057.572 sable_ircd #x1B[2m2026-03-15T18:40:57.571929Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] } 1773600057.572 sable_ircd #x1B[2m2026-03-15T18:40:57.571980Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600057.572 sable_ircd #x1B[2m2026-03-15T18:40:57.572016Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090614098931712)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] } 1773600057.572 sable_ircd #x1B[2m2026-03-15T18:40:57.572061Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090614107320321)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600057.572 sable_ircd #x1B[2m2026-03-15T18:40:57.572092Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090614107320321)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] } 1773600057.577 sable_services #x1B[2m2026-03-15T18:40:57.576824Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: GetEvent([EventId(Snowflake(821090613641351169)), EventId(Snowflake(821090614098931712))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(821090613641351169)), EventId(Snowflake(821090614098931712))] 1773600057.577 sable_services #x1B[2m2026-03-15T18:40:57.576874Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: GetEvent([EventId(Snowflake(821090613641351169)), EventId(Snowflake(821090614098931712))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [] 1773600057.578 sable_ircd #x1B[2m2026-03-15T18:40:57.577834Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614107320321), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614107320321), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 821090613641351169, 99 => 821090614107320321) my clock=EventClock(1 => 821090614127890434, 99 => 821090614107320321) 1773600057.578 sable_ircd #x1B[2m2026-03-15T18:40:57.578185Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614107320321), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169, 99 => 821090614107320321), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600057.582 sable_ircd #x1B[2m2026-03-15T18:40:57.581911Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }) 1773600057.582 sable_ircd #x1B[2m2026-03-15T18:40:57.581955Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] } 1773600057.582 sable_ircd #x1B[2m2026-03-15T18:40:57.582084Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600057.582 sable_ircd #x1B[2m2026-03-15T18:40:57.582120Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090614128291842)), timestamp: 1773600057, change: EventComplete(EventComplete), users_to_notify: [] } 1773600057.618 sable_ircd #x1B[2m2026-03-15T18:40:57.618026Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: BulkEvents([]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [] 1773600057.632 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname 1773600057.632 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1773600057.632 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1773600057.632 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1773600057.632 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2026-03-15 18:40:57.535217436 UTC 1773600057.632 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1773600057.632 S -> chkSvs: :My.Little.Server 005 chkSvs EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1773600057.632 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing 1773600057.632 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs + 1773600057.632 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1773600057.632 chkSvs -> S: CAP LS 302 1773600057.633 sable_ircd #x1B[2m2026-03-15T18:40:57.632580Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.633 sable_ircd #x1B[2m2026-03-15T18:40:57.632641Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP LS 302" 1773600057.633 sable_ircd #x1B[2m2026-03-15T18:40:57.632773Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1773600057.682 chkSvs -> S: PING synchronize509.361718078 1773600057.682 S -> chkSvs: :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1773600057.683 sable_ircd #x1B[2m2026-03-15T18:40:57.682869Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.683 sable_ircd #x1B[2m2026-03-15T18:40:57.682937Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize509.361718078" 1773600057.683 sable_ircd #x1B[2m2026-03-15T18:40:57.683069Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :synchronize509.361718078 1773600057.683 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize509.361718078 1773600057.683 chkSvs -> S: QUIT 1773600057.684 chkSvs -> S: PING synchronize509.362946641 1773600057.684 sable_ircd #x1B[2m2026-03-15T18:40:57.683749Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.684 sable_ircd #x1B[2m2026-03-15T18:40:57.683792Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"QUIT" 1773600057.684 sable_ircd #x1B[2m2026-03-15T18:40:57.683855Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600057.684 sable_ircd #x1B[2m2026-03-15T18:40:57.683886Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize509.362946641" 1773600057.938 sable_history #x1B[2m2027-03-15T19:27:41.253412Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(953373944717713462)), timestamp: 1805138861, clock: EventClock(1 => 953361426351656975, 50 => 953373693059473461, 99 => 953361416491249668), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1805138861 }) }; event clock=EventClock(1 => 953361426351656975, 50 => 953373693059473461, 99 => 953361416491249668) my clock=EventClock(1 => 953361426351656975, 50 => 953373693059473461, 99 => 953361416491249668) 1773600057.938 sable_history #x1B[2m2027-03-15T19:27:41.254958Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1773600058.187 sable_ircd #x1B[2m2026-03-15T18:40:58.187111Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): ERROR :Client quit 1773600058.187 sable_ircd #x1B[2m2026-03-15T18:40:58.187263Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mCloseConnection(ConnectionId(ListenerId(0), 2)) 1773600058.187 sable_ircd #x1B[2m2026-03-15T18:40:58.187301Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::connection_collection#x1B[0m#x1B[2m:#x1B[0m Removing connection ConnectionId(ListenerId(0), 2) 1773600058.188 S -> chkSvs: ERROR :Client quit 1773600058.188 sable_ircd #x1B[2m2026-03-15T18:40:58.187453Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 821090614127890434, 99 => 821090614128291842) my clock=EventClock(1 => 821090614127890434, 99 => 821090614128291842) 1773600058.188 chkSvs: disconnects from server. 1773600058.188 1: connects to server. 1773600058.188 1 -> S: NICK jilles 1773600058.188 1 -> S: USER r e g :user 1773600058.188 sable_ircd #x1B[2m2026-03-15T18:40:58.187856Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600058.188 sable_ircd #x1B[2m2026-03-15T18:40:58.187875Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m Connection error #x1B[3mconnection#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed 1773600058.188 sable_ircd #x1B[2m2026-03-15T18:40:58.187971Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600058.188 sable_ircd #x1B[2m2026-03-15T18:40:58.188382Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 3), remote_addr: 127.0.0.1, tls_info: None } 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.188498Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.188568Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.188628Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE * :*** Looking up your hostname 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.188767Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.188824Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK jilles" 1773600058.189 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.188976Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 509, tv_nsec: 868074897 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("jilles")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.189051Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.189078Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.189106Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER r e g :user" 1773600058.189 sable_ircd #x1B[2m2026-03-15T18:40:58.189169Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 509, tv_nsec: 868074897 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("jilles")), realname: OnceLock(Realname("user")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1773600058.190 sable_ircd #x1B[2m2026-03-15T18:40:58.190113Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 821090616866770947, 99 => 821090614128291842) my clock=EventClock(1 => 821090616866770947, 99 => 821090614128291842) 1773600058.191 sable_ircd #x1B[2m2026-03-15T18:40:58.190834Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600058.191 sable_ircd #x1B[2m2026-03-15T18:40:58.190961Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events 1773600058.191 sable_ircd #x1B[2m2026-03-15T18:40:58.190995Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 3): 127.0.0.1/Some(Hostname("localhost")) 1773600058.191 sable_ircd #x1B[2m2026-03-15T18:40:58.191031Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE * :*** Found your hostname: localhost 1773600058.191 sable_ircd #x1B[2m2026-03-15T18:40:58.191063Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 509, tv_nsec: 868074897 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("jilles")), realname: OnceLock(Realname("user")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1773600058.191 sable_ircd #x1B[2m2026-03-15T18:40:58.191120Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mRegisterClient(ConnectionId(ListenerId(0), 3)) 1773600058.192 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1773600058.196 sable_ircd #x1B[2m2026-03-15T18:40:58.195515Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, clock: EventClock(1 => 821090616879353860, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090616883548163)), NewUserConnection { user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 })) }) }; event clock=EventClock(1 => 821090616879353860, 99 => 821090614128291842) my clock=EventClock(1 => 821090616879353860, 99 => 821090614128291842) 1773600058.196 sable_ircd #x1B[2m2026-03-15T18:40:58.195906Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, clock: EventClock(1 => 821090616879353860, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090616883548163)), NewUserConnection { user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 })) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600058.196 sable_ircd #x1B[2m2026-03-15T18:40:58.196023Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(821090614127890432)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(821090614127890433)), user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 } }), users_to_notify: [] }) 1773600058.196 sable_ircd #x1B[2m2026-03-15T18:40:58.196067Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(821090614127890432)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(821090614127890433)), user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 } }), users_to_notify: [] } 1773600058.196 sable_ircd #x1B[2m2026-03-15T18:40:58.196125Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600058.196 sable_ircd #x1B[2m2026-03-15T18:40:58.196154Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] } 1773600058.197 sable_services #x1B[2m2026-03-15T18:40:58.197330Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 821090616866770947, 99 => 821090614128291842) my clock=EventClock(1 => 821090613641351169, 99 => 821090614128291842) 1773600058.198 sable_services #x1B[2m2026-03-15T18:40:58.197445Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(821090616866770947))] 1773600058.198 sable_services #x1B[2m2026-03-15T18:40:58.197792Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.199914Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(821090614127890432)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.199958Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(821090614127890432)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.200031Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.200065Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] } 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.200137Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 1) }), users_to_notify: [] }) 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.200181Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 1) }), users_to_notify: [] } 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.200252Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 2), connection: UserConnectionId(Snowflake(821090616883548163)) }), users_to_notify: [] }) 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.200297Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 2), connection: UserConnectionId(Snowflake(821090616883548163)) }), users_to_notify: [] } 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.200371Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 001 jilles :Welcome to the test Internet Relay Chat network, jilles 1773600058.200 sable_ircd #x1B[2m2026-03-15T18:40:58.200453Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 002 jilles :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1773600058.201 sable_ircd #x1B[2m2026-03-15T18:40:58.200559Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 003 jilles :This server was created 2026-03-15 18:40:58.200511601 UTC 1773600058.201 sable_ircd #x1B[2m2026-03-15T18:40:58.200644Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 004 jilles My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1773600058.201 sable_ircd #x1B[2m2026-03-15T18:40:58.200731Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 005 jilles EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1773600058.201 sable_ircd #x1B[2m2026-03-15T18:40:58.200779Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 422 jilles :MOTD File is missing 1773600058.201 sable_ircd #x1B[2m2026-03-15T18:40:58.200822Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :jilles!r@localhost MODE jilles + 1773600058.201 sable_ircd #x1B[2m2026-03-15T18:40:58.200858Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE jilles :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1773600058.201 sable_ircd #x1B[2m2026-03-15T18:40:58.200926Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600058.201 sable_ircd #x1B[2m2026-03-15T18:40:58.200959Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] } 1773600058.201 S -> 1: :My.Little.Server 001 jilles :Welcome to the test Internet Relay Chat network, jilles 1773600058.231 sable_services #x1B[2m2026-03-15T18:40:58.230927Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 821090614127890434, 99 => 821090614128291842) my clock=EventClock(1 => 821090613641351169, 99 => 821090614128291842) 1773600058.231 sable_services #x1B[2m2026-03-15T18:40:58.230987Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(821090614127890434))] 1773600058.231 sable_services #x1B[2m2026-03-15T18:40:58.231291Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600058.239 sable_ircd #x1B[2m2026-03-15T18:40:58.238815Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090616866770947))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(821090616866770947))] 1773600058.239 sable_ircd #x1B[2m2026-03-15T18:40:58.238875Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090616866770947))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }] 1773600058.241 sable_services #x1B[2m2026-03-15T18:40:58.240885Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, clock: EventClock(1 => 821090616879353860, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090616883548163)), NewUserConnection { user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, clock: EventClock(1 => 821090616879353860, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090616883548163)), NewUserConnection { user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 })) }) }; event clock=EventClock(1 => 821090616879353860, 99 => 821090614128291842) my clock=EventClock(1 => 821090613641351169, 99 => 821090614128291842) 1773600058.242 sable_services #x1B[2m2026-03-15T18:40:58.240949Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, clock: EventClock(1 => 821090616879353860, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090616883548163)), NewUserConnection { user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(821090616879353860))] 1773600058.242 sable_services #x1B[2m2026-03-15T18:40:58.241353Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, clock: EventClock(1 => 821090616879353860, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090616883548163)), NewUserConnection { user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, clock: EventClock(1 => 821090616879353860, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090616883548163)), NewUserConnection { user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 })) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600058.272 sable_ircd #x1B[2m2026-03-15T18:40:58.271938Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090614127890434))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(821090614127890434))] 1773600058.272 sable_ircd #x1B[2m2026-03-15T18:40:58.272003Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090614127890434))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }] 1773600058.280 sable_services #x1B[2m2026-03-15T18:40:58.279894Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }] 1773600058.280 sable_services #x1B[2m2026-03-15T18:40:58.279976Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 821090614127890434, 99 => 821090614128291842) my clock=EventClock(1 => 821090613641351169, 99 => 821090614128291842) 1773600058.280 sable_services #x1B[2m2026-03-15T18:40:58.280021Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(821090614127890434))] 1773600058.283 sable_ircd #x1B[2m2026-03-15T18:40:58.282826Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090616879353860))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(821090616879353860))] 1773600058.283 sable_ircd #x1B[2m2026-03-15T18:40:58.282875Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090616879353860))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1773600058.301 1 -> S: PING synchronize509.980889582 1773600058.302 S -> 1: :My.Little.Server 002 jilles :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1773600058.302 S -> 1: :My.Little.Server 003 jilles :This server was created 2026-03-15 18:40:58.200511601 UTC 1773600058.302 S -> 1: :My.Little.Server 004 jilles My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1773600058.302 S -> 1: :My.Little.Server 005 jilles EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1773600058.302 S -> 1: :My.Little.Server 422 jilles :MOTD File is missing 1773600058.302 S -> 1: :jilles!r@localhost MODE jilles + 1773600058.302 S -> 1: :My.Little.Server NOTICE jilles :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1773600058.302 sable_ircd #x1B[2m2026-03-15T18:40:58.301930Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600058.302 sable_ircd #x1B[2m2026-03-15T18:40:58.301989Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize509.980889582" 1773600058.302 sable_ircd #x1B[2m2026-03-15T18:40:58.302104Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server PONG My.Little.Server :synchronize509.980889582 1773600058.302 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize509.980889582 1773600058.302 1 -> S: REGISTER * * sesame 1773600058.303 sable_ircd #x1B[2m2026-03-15T18:40:58.302740Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600058.303 sable_ircd #x1B[2m2026-03-15T18:40:58.302789Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"REGISTER * * sesame" 1773600058.303 sable_ircd #x1B[2m2026-03-15T18:40:58.302988Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Found target peer, sending message #x1B[3mtarget#x1B[0m#x1B[2m=#x1B[0mPeerConfig { name: ServerName("My.Little.Services"), address: "127.0.0.1:57643", fingerprint: "cc2a8a36608db26f5aae95ecabe9ee92630dfa48" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("jilles"), "sesame")) } 1773600058.303 sable_ircd #x1B[2m2026-03-15T18:40:58.303205Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("jilles"), "sesame")) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600058.305 sable_ircd #x1B[2m2026-03-15T18:40:58.305047Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(26) }) 1773600058.313 sable_services #x1B[2m2026-03-15T18:40:58.312857Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }] 1773600058.313 sable_services #x1B[2m2026-03-15T18:40:58.312934Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }; event clock=EventClock(1 => 821090613641351169) my clock=EventClock(1 => 821090613641351169, 99 => 821090614128291842) 1773600058.313 sable_services #x1B[2m2026-03-15T18:40:58.313007Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(821090616866770947)), timestamp: 1773600058, clock: EventClock(1 => 821090614127890434, 99 => 821090614128291842), target: UserConnection(UserConnectionId(Snowflake(821090614127890433))), details: UserDisconnect(UserDisconnect) } 1773600058.313 sable_services #x1B[2m2026-03-15T18:40:58.313046Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1773600058.313 sable_services #x1B[2m2026-03-15T18:40:58.313083Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(821090616900325381)), timestamp: 1773600058, clock: EventClock(1 => 821090616879353860, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090616883548163)), NewUserConnection { user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 })) }) } 1773600058.324 sable_services #x1B[2m2026-03-15T18:40:58.323994Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(821090616879353860)), timestamp: 1773600058, clock: EventClock(1 => 821090616866770947, 99 => 821090614128291842), target: User(UserId(Snowflake(821090614127890432))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1773600058.346 sable_services #x1B[2m2026-03-15T18:40:58.346015Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(RegisterUser(Nickname("jilles"), "sesame")) 1773600058.346 sable_services #x1B[2m2026-03-15T18:40:58.346062Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got register request #x1B[3maccount_name#x1B[0m#x1B[2m=#x1B[0mNickname("jilles") 1773600058.351 sable_services #x1B[2m2026-03-15T18:40:58.350760Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server::command::user_commands#x1B[0m#x1B[2m:#x1B[0m Successfully created account #x1B[3mnew_account#x1B[0m#x1B[2m=#x1B[0mAccount { id: AccountId(Snowflake(821090617534066688)), name: Nickname("jilles"), authorised_fingerprints: [] } 1773600058.351 sable_services #x1B[2m2026-03-15T18:40:58.351023Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090617550843907)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: Account(AccountId(Snowflake(821090617534066688))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(821090617534066688)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 821090616900325381, 99 => 821090614128291842) my clock=EventClock(1 => 821090616900325381, 99 => 821090614128291842) 1773600058.351 sable_services #x1B[2m2026-03-15T18:40:58.351378Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090617550843907)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: Account(AccountId(Snowflake(821090617534066688))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(821090617534066688)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600058.392 sable_ircd #x1B[2m2026-03-15T18:40:58.391839Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got targeted message response #x1B[3mresponse#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: TargetedMessageResponse(Services(LogUserIn(AccountId(Snowflake(821090617534066688))))) } } 1773600058.392 sable_ircd #x1B[2m2026-03-15T18:40:58.392037Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090614127890434))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(821090614127890434))] 1773600058.392 sable_ircd #x1B[2m2026-03-15T18:40:58.392089Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090614127890434))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }] 1773600058.392 sable_ircd #x1B[2m2026-03-15T18:40:58.392318Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): REGISTER SUCCESS jilles :You have successfully registered 1773600058.392 sable_ircd #x1B[2m2026-03-15T18:40:58.392385Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers 1773600058.392 sable_ircd #x1B[2m2026-03-15T18:40:58.392438Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mStateChange(User(UserId(Snowflake(821090616883548162))), UserLogin(UserLogin { account: Some(AccountId(Snowflake(821090617534066688))) })) 1773600058.393 sable_ircd #x1B[2m2026-03-15T18:40:58.392627Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(821090617534066688))) }) }; event clock=EventClock(1 => 821090616900325381, 99 => 821090614128291842) my clock=EventClock(1 => 821090616900325381, 99 => 821090614128291842) 1773600058.393 sable_ircd #x1B[2m2026-03-15T18:40:58.392984Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(821090617534066688))) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600058.395 sable_ircd #x1B[2m2026-03-15T18:40:58.395141Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 3), old_account: None, new_account: Some(AccountId(Snowflake(821090617534066688))) }), users_to_notify: [] }) 1773600058.395 sable_ircd #x1B[2m2026-03-15T18:40:58.395190Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 3), old_account: None, new_account: Some(AccountId(Snowflake(821090617534066688))) }), users_to_notify: [] } 1773600058.395 sable_ircd #x1B[2m2026-03-15T18:40:58.395265Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600058.395 sable_ircd #x1B[2m2026-03-15T18:40:58.395244Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090617550843907)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: Account(AccountId(Snowflake(821090617534066688))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(821090617534066688)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090617550843907)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: Account(AccountId(Snowflake(821090617534066688))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(821090617534066688)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 821090616900325381, 99 => 821090614128291842) my clock=EventClock(1 => 821090617726603270, 99 => 821090614128291842) 1773600058.395 sable_ircd #x1B[2m2026-03-15T18:40:58.395294Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] } 1773600058.396 sable_ircd #x1B[2m2026-03-15T18:40:58.395593Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090617550843907)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: Account(AccountId(Snowflake(821090617534066688))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(821090617534066688)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090617550843907)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: Account(AccountId(Snowflake(821090617534066688))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(821090617534066688)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600058.398 sable_ircd #x1B[2m2026-03-15T18:40:58.397490Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090617550843907)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600058.398 sable_ircd #x1B[2m2026-03-15T18:40:58.397559Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090617550843907)), timestamp: 1773600058, change: EventComplete(EventComplete), users_to_notify: [] } 1773600058.433 sable_services #x1B[2m2026-03-15T18:40:58.432927Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(821090614127890434)), timestamp: 1773600057, clock: EventClock(1 => 821090613641351169), target: User(UserId(Snowflake(821090614127890432))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(821090614127890433)), NewUserConnection { user: UserId(Snowflake(821090614127890432)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600057 })) }) }] 1773600058.436 sable_services #x1B[2m2026-03-15T18:40:58.435840Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(821090617534066688))) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(821090617534066688))) }) }; event clock=EventClock(1 => 821090616900325381, 99 => 821090614128291842) my clock=EventClock(1 => 821090616900325381, 99 => 821090617550843907) 1773600058.436 sable_services #x1B[2m2026-03-15T18:40:58.436234Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(821090617534066688))) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090617726603270)), timestamp: 1773600058, clock: EventClock(1 => 821090616900325381, 99 => 821090614128291842), target: User(UserId(Snowflake(821090616883548162))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(821090617534066688))) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600058.503 1 -> S: PING synchronize510.182125971 1773600058.503 S -> 1: REGISTER SUCCESS jilles :You have successfully registered 1773600058.503 sable_ircd #x1B[2m2026-03-15T18:40:58.503220Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600058.503 sable_ircd #x1B[2m2026-03-15T18:40:58.503298Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize510.182125971" 1773600059.006 sable_ircd #x1B[2m2026-03-15T18:40:59.005588Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server PONG My.Little.Server :synchronize510.182125971 1773600059.006 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize510.182125971 1773600059.006 1 -> S: QUIT 1773600059.007 sable_ircd #x1B[2m2026-03-15T18:40:59.006534Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600059.007 sable_ircd #x1B[2m2026-03-15T18:40:59.006602Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"QUIT" 1773600059.106 1 -> S: PING synchronize510.78580713 1773600059.107 sable_ircd #x1B[2m2026-03-15T18:40:59.106854Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600059.107 sable_ircd #x1B[2m2026-03-15T18:40:59.106921Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize510.78580713" 1773600060.107 1: waiting… 1773600060.114 sable_ircd #x1B[2m2026-03-15T18:41:00.112454Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): ERROR :Client quit 1773600060.114 sable_ircd #x1B[2m2026-03-15T18:41:00.112646Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mCloseConnection(ConnectionId(ListenerId(0), 3)) 1773600060.114 sable_ircd #x1B[2m2026-03-15T18:41:00.112679Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::connection_collection#x1B[0m#x1B[2m:#x1B[0m Removing connection ConnectionId(ListenerId(0), 3) 1773600060.114 sable_ircd #x1B[2m2026-03-15T18:41:00.112831Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 821090617726603270, 99 => 821090617550843907) my clock=EventClock(1 => 821090617726603270, 99 => 821090617550843907) 1773600060.114 sable_ircd #x1B[2m2026-03-15T18:41:00.113297Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600060.115 S -> 1: ERROR :Client quit 1773600060.115 sable_ircd #x1B[2m2026-03-15T18:41:00.115136Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m Connection error #x1B[3mconnection#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed 1773600060.115 sable_ircd #x1B[2m2026-03-15T18:41:00.115255Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600060.117 sable_ircd #x1B[2m2026-03-15T18:41:00.116589Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, clock: EventClock(1 => 821090624940806151, 99 => 821090617550843907), target: User(UserId(Snowflake(821090616883548162))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 821090624940806151, 99 => 821090617550843907) my clock=EventClock(1 => 821090624940806151, 99 => 821090617550843907) 1773600060.117 sable_ircd #x1B[2m2026-03-15T18:41:00.117022Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, clock: EventClock(1 => 821090624940806151, 99 => 821090617550843907), target: User(UserId(Snowflake(821090616883548162))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600060.117 sable_ircd #x1B[2m2026-03-15T18:41:00.117016Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(821090616883548163)), user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 } }), users_to_notify: [] }) 1773600060.117 sable_ircd #x1B[2m2026-03-15T18:41:00.117293Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(821090616883548163)), user: UserId(Snowflake(821090616883548162)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773600058 } }), users_to_notify: [] } 1773600060.117 sable_ircd #x1B[2m2026-03-15T18:41:00.117375Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600060.117 sable_ircd #x1B[2m2026-03-15T18:41:00.117411Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, change: EventComplete(EventComplete), users_to_notify: [] } 1773600060.121 sable_ircd #x1B[2m2026-03-15T18:41:00.121111Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 3), nickname: Nickname("jilles"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1773600060.121 sable_ircd #x1B[2m2026-03-15T18:41:00.121160Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(821090616883548162)), 3), nickname: Nickname("jilles"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1773600060.121 sable_ircd #x1B[2m2026-03-15T18:41:00.121223Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, change: EventComplete(EventComplete), users_to_notify: [] }) 1773600060.121 sable_ircd #x1B[2m2026-03-15T18:41:00.121263Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, change: EventComplete(EventComplete), users_to_notify: [] } 1773600060.122 sable_services #x1B[2m2026-03-15T18:41:00.121772Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, clock: EventClock(1 => 821090624940806151, 99 => 821090617550843907), target: User(UserId(Snowflake(821090616883548162))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, clock: EventClock(1 => 821090624940806151, 99 => 821090617550843907), target: User(UserId(Snowflake(821090616883548162))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 821090624940806151, 99 => 821090617550843907) my clock=EventClock(1 => 821090617726603270, 99 => 821090617550843907) 1773600060.122 sable_services #x1B[2m2026-03-15T18:41:00.121836Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, clock: EventClock(1 => 821090624940806151, 99 => 821090617550843907), target: User(UserId(Snowflake(821090616883548162))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(821090624940806151))] 1773600060.122 sable_services #x1B[2m2026-03-15T18:41:00.122232Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, clock: EventClock(1 => 821090624940806151, 99 => 821090617550843907), target: User(UserId(Snowflake(821090616883548162))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, clock: EventClock(1 => 821090624940806151, 99 => 821090617550843907), target: User(UserId(Snowflake(821090616883548162))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600060.158 sable_services #x1B[2m2026-03-15T18:41:00.157968Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 821090617726603270, 99 => 821090617550843907) my clock=EventClock(1 => 821090617726603270, 99 => 821090617550843907) 1773600060.158 sable_services #x1B[2m2026-03-15T18:41:00.158039Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(821090624957583368)), timestamp: 1773600060, clock: EventClock(1 => 821090624940806151, 99 => 821090617550843907), target: User(UserId(Snowflake(821090616883548162))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1773600060.158 sable_services #x1B[2m2026-03-15T18:41:00.158361Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1773600057), content: NewEvent(Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:45553 (127.0.0.1:45553) 1773600060.164 sable_ircd #x1B[2m2026-03-15T18:41:00.163787Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090624940806151))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(821090624940806151))] 1773600060.164 sable_ircd #x1B[2m2026-03-15T18:41:00.163843Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: GetEvent([EventId(Snowflake(821090624940806151))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }] 1773600060.205 sable_services #x1B[2m2026-03-15T18:41:00.204936Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1773600057), content: BulkEvents([Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(821090624940806151)), timestamp: 1773600060, clock: EventClock(1 => 821090617726603270, 99 => 821090617550843907), target: UserConnection(UserConnectionId(Snowflake(821090616883548163))), details: UserDisconnect(UserDisconnect) }] 1773600060.215 1 -> S: PING synchronize511.894511974 1773600060.216 1: connects to server. 1773600060.216 1 -> S: CAP LS 302 1773600060.216 sable_ircd #x1B[2m2026-03-15T18:41:00.215935Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 4), remote_addr: 127.0.0.1, tls_info: None } 1773600060.216 sable_ircd #x1B[2m2026-03-15T18:41:00.216074Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600060.216 sable_ircd #x1B[2m2026-03-15T18:41:00.216128Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1773600060.216 sable_ircd #x1B[2m2026-03-15T18:41:00.216219Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Looking up your hostname 1773600060.216 sable_ircd #x1B[2m2026-03-15T18:41:00.216397Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600060.217 sable_ircd #x1B[2m2026-03-15T18:41:00.216463Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP LS 302" 1773600060.217 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1773600060.217 sable_ircd #x1B[2m2026-03-15T18:41:00.216644Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1773600060.217 S -> 1: :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1773600060.217 1 -> S: CAP REQ :sasl 1773600060.217 sable_ircd #x1B[2m2026-03-15T18:41:00.217330Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events 1773600060.217 sable_ircd #x1B[2m2026-03-15T18:41:00.217362Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 4): 127.0.0.1/Some(Hostname("localhost")) 1773600060.217 sable_ircd #x1B[2m2026-03-15T18:41:00.217389Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Found your hostname: localhost 1773600060.217 sable_ircd #x1B[2m2026-03-15T18:41:00.217413Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 511, tv_nsec: 895654159 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1773600060.218 sable_ircd #x1B[2m2026-03-15T18:41:00.217633Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600060.218 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1773600060.218 sable_ircd #x1B[2m2026-03-15T18:41:00.217692Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP REQ :sasl" 1773600060.218 sable_ircd #x1B[2m2026-03-15T18:41:00.217804Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server CAP * ACK :sasl 1773600060.218 sable_ircd #x1B[2m2026-03-15T18:41:00.217836Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mUpdateConnectionCaps(ConnectionId(ListenerId(0), 4), ClientCapabilitySet(8)) 1773600060.259 S -> 1: :My.Little.Server CAP * ACK :sasl 1773600060.259 1 -> S: AUTHENTICATE FOO 1773600060.259 sable_ircd #x1B[2m2026-03-15T18:41:00.259388Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1773600060.259 sable_ircd #x1B[2m2026-03-15T18:41:00.259456Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"AUTHENTICATE FOO" 1773600060.260 sable_ircd #x1B[2m2026-03-15T18:41:00.259695Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::command::handlers::services::sasl#x1B[0m#x1B[2m:#x1B[0m Beginning new SASL session #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(821090625557368836)) 1773600060.260 sable_ircd #x1B[2m2026-03-15T18:41:00.259839Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Found target peer, sending message #x1B[3mtarget#x1B[0m#x1B[2m=#x1B[0mPeerConfig { name: ServerName("My.Little.Services"), address: "127.0.0.1:57643", fingerprint: "cc2a8a36608db26f5aae95ecabe9ee92630dfa48" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(821090625557368836)), "FOO")) } 1773600060.260 sable_ircd #x1B[2m2026-03-15T18:41:00.260100Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1773600057), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(821090625557368836)), "FOO")) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57643 (127.0.0.1:57643) 1773600060.262 sable_ircd #x1B[2m2026-03-15T18:41:00.262007Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(35) }) 1773600060.303 sable_services #x1B[2m2026-03-15T18:41:00.303020Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(BeginAuthenticate(SaslSessionId(Snowflake(821090625557368836)), "FOO")) 1773600060.303 sable_services #x1B[2m2026-03-15T18:41:00.303074Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got begin authenticate #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(821090625557368836)) #x1B[3mmechanism#x1B[0m#x1B[2m=#x1B[0m"FOO" 1773600060.344 sable_ircd #x1B[2m2026-03-15T18:41:00.343897Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got targeted message response #x1B[3mresponse#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1773600057), content: TargetedMessageResponse(Services(Authenticate(Fail))) } } 1773600060.344 sable_ircd #x1B[2m2026-03-15T18:41:00.344148Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 904 * :SASL authentication failed 1773600060.344 sable_ircd #x1B[2m2026-03-15T18:41:00.344225Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers 1773600060.345 S -> 1: :My.Little.Server 904 * :SASL authentication failed 1773600060.347 sable_ircd #x1B[2m2026-03-15T18:41:00.347107Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error in outbound network sync connection: I/O error: unexpected end of file 1773600060.347 sable_ircd #x1B[2m2026-03-15T18:41:00.347328Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1mhandle_connection#x1B[0m#x1B[1m{#x1B[0m#x1B[3mconn#x1B[0m#x1B[2m=#x1B[0mPollEvented { io: Some(TcpStream { addr: 127.0.0.1:45553, peer: 127.0.0.1:53391, fd: 19 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x560ad8cbb990, tail_position: 0 }, semaphore: Semaphore(0), rx_waker: AtomicWaker, tx_count: 2, rx_fields: "..." } } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error handling message: I/O error: unexpected end of file 1773600060.347 sable_ircd #x1B[2m2026-03-15T18:41:00.347357Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error in outbound network sync connection: I/O error: unexpected end of file 1773600060.354 1: disconnects from server.