--------------------------------- Captured Out --------------------------------- ---- new test ---- 1782833845.084 sable_ircd uid=1001 1782833845.085 sable_services uid=1001 1782833845.086 sable_services #x1B[2m2026-06-30T15:37:25.085482Z#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:38021", fingerprint: "7b2379e2ba2dd358a7749110cfdad0d0fbad7821" } 1782833845.086 sable_services #x1B[2m2026-06-30T15:37:25.085734Z#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), 1782833845), 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 Could not connect to 127.0.0.1:38021. Last error: I/O error: Connection refused (os error 111) 1782833845.086 sable_services #x1B[2m2026-06-30T15:37:25.085787Z#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), 1782833845), 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 #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1782833845.088 sable_ircd #x1B[2m2026-06-30T15:37:25.087597Z#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(859819926196588544)), timestamp: 1782833845, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Server"), ts: 1782833845, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1782833845.088 sable_ircd #x1B[2m2026-06-30T15:37:25.087720Z#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 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.087937Z#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(859819926196588544)), timestamp: 1782833845, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Server"), ts: 1782833845, 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 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.088112Z#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(859819926196588544)), timestamp: 1782833845, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.088155Z#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(859819926196588544)), timestamp: 1782833845, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.088222Z#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(859819926196588544)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.088256Z#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(859819926196588544)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] } 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.088587Z#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(859819926200782849)), timestamp: 1782833845, clock: EventClock(1 => 859819926196588544), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1782833845 }) }; event clock=EventClock(1 => 859819926196588544) my clock=EventClock(1 => 859819926196588544) 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.088641Z#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 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.088664Z#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 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.088941Z#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(859819926200782849)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833845.089 sable_ircd #x1B[2m2026-06-30T15:37:25.088986Z#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(859819926200782849)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] } 1782833845.179 sable_services #x1B[2m2026-06-30T15:37:25.179412Z#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:38021", fingerprint: "7b2379e2ba2dd358a7749110cfdad0d0fbad7821" } 1782833845.180 sable_services #x1B[2m2026-06-30T15:37:25.179681Z#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), 1782833845), 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:38021 (127.0.0.1:38021) 1782833845.182 sable_ircd #x1B[2m2026-06-30T15:37:25.182098Z#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 } 1782833845.182 sable_ircd #x1B[2m2026-06-30T15:37:25.182255Z#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 1782833845.182 sable_ircd #x1B[2m2026-06-30T15:37:25.182322Z#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 1782833845.182 sable_ircd #x1B[2m2026-06-30T15:37:25.182431Z#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 1782833845.183 sable_ircd #x1B[2m2026-06-30T15:37:25.182591Z#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 1782833845.183 sable_ircd #x1B[2m2026-06-30T15:37:25.182646Z#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" 1782833845.183 sable_ircd #x1B[2m2026-06-30T15:37:25.182748Z#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 1782833845.183 sable_ircd #x1B[2m2026-06-30T15:37:25.183112Z#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)) 1782833845.184 sable_ircd #x1B[2m2026-06-30T15:37:25.183452Z#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) 1782833845.184 sable_ircd #x1B[2m2026-06-30T15:37:25.183720Z#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 1782833845.184 sable_ircd #x1B[2m2026-06-30T15:37:25.183988Z#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 1782833845.184 sable_ircd #x1B[2m2026-06-30T15:37:25.184119Z#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 1782833845.203 chkSvs: connects to server. 1782833845.203 chkSvs -> S: NICK chkSvs 1782833845.204 chkSvs -> S: USER chk chk chk chk 1782833845.204 sable_ircd #x1B[2m2026-06-30T15:37:25.203709Z#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 } 1782833845.204 sable_ircd #x1B[2m2026-06-30T15:37:25.203869Z#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 1782833845.204 sable_ircd #x1B[2m2026-06-30T15:37:25.203923Z#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 1782833845.204 sable_ircd #x1B[2m2026-06-30T15:37:25.203984Z#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 1782833845.204 sable_ircd #x1B[2m2026-06-30T15:37:25.204129Z#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 1782833845.204 sable_ircd #x1B[2m2026-06-30T15:37:25.204187Z#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" 1782833845.204 sable_ircd #x1B[2m2026-06-30T15:37:25.204333Z#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: 629, tv_nsec: 427617319 }, 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 1782833845.204 sable_ircd #x1B[2m2026-06-30T15:37:25.204441Z#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 1782833845.205 sable_ircd #x1B[2m2026-06-30T15:37:25.204499Z#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 1782833845.205 sable_ircd #x1B[2m2026-06-30T15:37:25.204549Z#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" 1782833845.205 sable_ircd #x1B[2m2026-06-30T15:37:25.204637Z#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: 629, tv_nsec: 427617319 }, 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 1782833845.205 sable_ircd #x1B[2m2026-06-30T15:37:25.205099Z#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 1782833845.205 sable_ircd #x1B[2m2026-06-30T15:37:25.205142Z#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")) 1782833845.205 sable_ircd #x1B[2m2026-06-30T15:37:25.205173Z#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 1782833845.205 sable_ircd #x1B[2m2026-06-30T15:37:25.205195Z#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: 629, tv_nsec: 427617319 }, 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 1782833845.205 sable_ircd #x1B[2m2026-06-30T15:37:25.205237Z#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)) 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.205487Z#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(859819926691516418)), timestamp: 1782833845, clock: EventClock(1 => 859819926200782849), target: User(UserId(Snowflake(859819926691516416))), 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(859819926691516417)), NewUserConnection { user: UserId(Snowflake(859819926691516416)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833845 })) }) }; event clock=EventClock(1 => 859819926200782849) my clock=EventClock(1 => 859819926200782849) 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.205577Z#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 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.205833Z#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(859819926691516418)), timestamp: 1782833845, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819926691516416)), 1) }), users_to_notify: [] }) 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.205879Z#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(859819926691516418)), timestamp: 1782833845, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819926691516416)), 1) }), users_to_notify: [] } 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.205944Z#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(859819926691516418)), timestamp: 1782833845, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819926691516416)), 2), connection: UserConnectionId(Snowflake(859819926691516417)) }), users_to_notify: [] }) 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.205979Z#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(859819926691516418)), timestamp: 1782833845, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819926691516416)), 2), connection: UserConnectionId(Snowflake(859819926691516417)) }), users_to_notify: [] } 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.206043Z#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 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.206089Z#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 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.206134Z#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-06-30 15:37:25.206117459 UTC 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.206180Z#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 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.206237Z#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 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.206276Z#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 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.206313Z#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 + 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.206344Z#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. 1782833845.206 sable_ircd #x1B[2m2026-06-30T15:37:25.206444Z#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(859819926691516418)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833845.207 sable_ircd #x1B[2m2026-06-30T15:37:25.206480Z#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(859819926691516418)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] } 1782833845.227 sable_ircd #x1B[2m2026-06-30T15:37:25.226644Z#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 1782833845.268 sable_services #x1B[2m2026-06-30T15:37:25.268112Z#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), 1782833845), content: NetworkState(Network { nick_bindings: {Nickname("chkSvs"): NickBinding { nick: Nickname("chkSvs"), user: UserId(Snowflake(859819926691516416)), timestamp: 1782833845, created: EventId(Snowflake(859819926691516418)) }}, historic_nick_users: HistoricNickStore { data: {} }, users: {UserId(Snowflake(859819926691516416)): User { id: UserId(Snowflake(859819926691516416)), serial: 2, user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, mode: UserMode { modes: UserModeSet(0) }, oper_privileges: None, account: None, session_key: None }}, historic_users: HistoricUserStore { users: {HistoricUserId(UserId(Snowflake(859819926691516416)), 1): HistoricUser { id: UserId(Snowflake(859819926691516416)), serial: 1, nickname: Nickname("chkSvs"), user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, account: None, timestamp: Some(1782833845) }, HistoricUserId(UserId(Snowflake(859819926691516416)), 2): HistoricUser { id: UserId(Snowflake(859819926691516416)), serial: 2, nickname: Nickname("chkSvs"), user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, account: None, timestamp: None }} }, user_connections: {UserConnectionId(Snowflake(859819926691516417)): UserConnection { id: UserConnectionId(Snowflake(859819926691516417)), user: UserId(Snowflake(859819926691516416)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833845 }}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1782833845, name: ServerName("My.Little.Server"), last_ping: 1782833845, 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: {"user_param_2": (0, String(_)), "user": (5, String(_)), "user_param_1": (3, String(_)), "nick": (4, String(_)), "realname": (1, String(_)), "host": (2, String(_)), "tls": (0, Boolean(_)), "ip": (0, Ip(_))} }, 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: {"ip": (0, Ip(_)), "mechanism": (0, String(_)), "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: {BuiltinAll: ChannelAccessSet(1114112), BuiltinVoice: ChannelAccessSet(4296081441), BuiltinOp: ChannelAccessSet(222192934775)}, 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 => 859819926691516418), cache_default_channel_roles: OnceLock(), alias_users: OnceLock() }) } 1782833845.268 sable_services #x1B[2m2026-06-30T15:37:25.268318Z#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 1782833845.268 sable_services #x1B[2m2026-06-30T15:37:25.268458Z#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 1782833845.269 sable_services #x1B[2m2026-06-30T15:37:25.268917Z#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(859819926956158976)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Services"), ts: 1782833845, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 859819926691516418) my clock=EventClock(1 => 859819926691516418) 1782833845.269 sable_services #x1B[2m2026-06-30T15:37:25.269374Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926956158976)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Services"), ts: 1782833845, 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:38021 (127.0.0.1:38021) 1782833845.271 sable_services #x1B[2m2026-06-30T15:37:25.271189Z#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(859819926968741889)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926956158976), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1782833845 }) }; event clock=EventClock(1 => 859819926691516418, 99 => 859819926956158976) my clock=EventClock(1 => 859819926691516418, 99 => 859819926956158976) 1782833845.272 sable_services #x1B[2m2026-06-30T15:37:25.271588Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926968741889)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926956158976), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1782833845 }) }) } #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:38021 (127.0.0.1:38021) 1782833845.272 sable_services #x1B[2m2026-06-30T15:37:25.271612Z#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(859819926956158976)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Services"), ts: 1782833845, 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 1782833845.275 sable_services #x1B[2m2026-06-30T15:37:25.275108Z#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(859819926985519106)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926968741889), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 859819926691516418, 99 => 859819926968741889) my clock=EventClock(1 => 859819926691516418, 99 => 859819926968741889) 1782833845.276 sable_services #x1B[2m2026-06-30T15:37:25.275406Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926985519106)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926968741889), 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:38021 (127.0.0.1:38021) 1782833845.276 sable_ircd #x1B[2m2026-06-30T15:37:25.276184Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926968741889)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926956158976), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1782833845 }) }) } }#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(859819926968741889)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926956158976), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1782833845 }) }; event clock=EventClock(1 => 859819926691516418, 99 => 859819926956158976) my clock=EventClock(1 => 859819926691516418) 1782833845.276 sable_ircd #x1B[2m2026-06-30T15:37:25.276277Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926968741889)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926956158976), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1782833845 }) }) } }#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(859819926956158976))] 1782833845.276 sable_ircd #x1B[2m2026-06-30T15:37:25.276326Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926968741889)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926956158976), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1782833845 }) }) } }#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 1782833845.304 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname 1782833845.304 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1782833845.304 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1782833845.304 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1782833845.304 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2026-06-30 15:37:25.206117459 UTC 1782833845.304 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1782833845.304 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 1782833845.304 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing 1782833845.304 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs + 1782833845.304 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1782833845.304 chkSvs -> S: CAP LS 302 1782833845.304 sable_ircd #x1B[2m2026-06-30T15:37:25.304080Z#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 1782833845.304 sable_ircd #x1B[2m2026-06-30T15:37:25.304136Z#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" 1782833845.304 sable_ircd #x1B[2m2026-06-30T15:37:25.304253Z#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 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 1782833845.313 sable_ircd #x1B[2m2026-06-30T15:37:25.312695Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926956158976)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Services"), ts: 1782833845, 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(859819926956158976)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Services"), ts: 1782833845, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 859819926691516418) my clock=EventClock(1 => 859819926691516418) 1782833845.313 sable_ircd #x1B[2m2026-06-30T15:37:25.312790Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926956158976)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Services"), ts: 1782833845, 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(859819926968741889)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926956158976), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1782833845 }) } 1782833845.313 sable_ircd #x1B[2m2026-06-30T15:37:25.312897Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926956158976)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Services"), ts: 1782833845, 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 1782833845.313 sable_ircd #x1B[2m2026-06-30T15:37:25.313166Z#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(859819926956158976)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1782833845, name: ServerName("My.Little.Services"), ts: 1782833845, 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 1782833845.313 sable_ircd #x1B[2m2026-06-30T15:37:25.313374Z#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(859819926956158976)), timestamp: 1782833845, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }) 1782833845.313 sable_ircd #x1B[2m2026-06-30T15:37:25.313422Z#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(859819926956158976)), timestamp: 1782833845, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] } 1782833845.314 sable_ircd #x1B[2m2026-06-30T15:37:25.313491Z#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(859819926956158976)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833845.314 sable_ircd #x1B[2m2026-06-30T15:37:25.313526Z#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(859819926956158976)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] } 1782833845.314 sable_ircd #x1B[2m2026-06-30T15:37:25.313580Z#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(859819926968741889)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833845.314 sable_ircd #x1B[2m2026-06-30T15:37:25.313614Z#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(859819926968741889)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] } 1782833845.318 sable_services #x1B[2m2026-06-30T15:37:25.317596Z#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), 1782833845), content: GetEvent([EventId(Snowflake(859819926956158976))]) } }#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(859819926956158976))] 1782833845.318 sable_services #x1B[2m2026-06-30T15:37:25.317637Z#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), 1782833845), content: GetEvent([EventId(Snowflake(859819926956158976))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [] 1782833845.320 sable_ircd #x1B[2m2026-06-30T15:37:25.319660Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926985519106)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926968741889), 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(859819926985519106)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926968741889), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 859819926691516418, 99 => 859819926968741889) my clock=EventClock(1 => 859819926691516418, 99 => 859819926968741889) 1782833845.320 sable_ircd #x1B[2m2026-06-30T15:37:25.320039Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926985519106)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926968741889), 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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819926985519106)), timestamp: 1782833845, clock: EventClock(1 => 859819926691516418, 99 => 859819926968741889), 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:59425 (127.0.0.1:59425) 1782833845.324 sable_ircd #x1B[2m2026-06-30T15:37:25.323866Z#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(859819926985519106)), timestamp: 1782833845, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }) 1782833845.324 sable_ircd #x1B[2m2026-06-30T15:37:25.323907Z#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(859819926985519106)), timestamp: 1782833845, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] } 1782833845.324 sable_ircd #x1B[2m2026-06-30T15:37:25.324012Z#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(859819926985519106)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833845.324 sable_ircd #x1B[2m2026-06-30T15:37:25.324048Z#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(859819926985519106)), timestamp: 1782833845, change: EventComplete(EventComplete), users_to_notify: [] } 1782833845.354 chkSvs -> S: PING synchronize629.577533864 1782833845.354 S -> chkSvs: :My.Little.Server CAP * LS :message-tags server-time echo-message 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 1782833845.355 sable_ircd #x1B[2m2026-06-30T15:37:25.354521Z#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 1782833845.355 sable_ircd #x1B[2m2026-06-30T15:37:25.354587Z#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 synchronize629.577533864" 1782833845.355 sable_ircd #x1B[2m2026-06-30T15:37:25.354719Z#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 :synchronize629.577533864 1782833845.355 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize629.577533864 1782833845.355 chkSvs -> S: CAP LS 302 1782833845.355 sable_ircd #x1B[2m2026-06-30T15:37:25.355402Z#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 1782833845.355 sable_ircd #x1B[2m2026-06-30T15:37:25.355463Z#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" 1782833845.359 sable_ircd #x1B[2m2026-06-30T15:37:25.358682Z#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), 1782833845), 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: [] 1782833845.405 chkSvs -> S: PING synchronize629.628907788 1782833845.406 sable_ircd #x1B[2m2026-06-30T15:37:25.405655Z#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 1782833845.406 sable_ircd #x1B[2m2026-06-30T15:37:25.405708Z#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 synchronize629.628907788" 1782833846.160 sable_ircd #x1B[2m2026-06-30T15:37:26.159545Z#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 1782833846.160 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 1782833847.161 chkSvs: waiting… 1782833847.164 sable_ircd #x1B[2m2026-06-30T15:37:27.164161Z#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 :synchronize629.628907788 1782833847.165 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize629.628907788 1782833847.165 chkSvs -> S: QUIT 1782833847.165 chkSvs -> S: PING synchronize631.388480574 1782833847.165 sable_ircd #x1B[2m2026-06-30T15:37:27.165147Z#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 1782833847.165 sable_ircd #x1B[2m2026-06-30T15:37:27.165216Z#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" 1782833847.165 sable_ircd #x1B[2m2026-06-30T15:37:27.165316Z#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 1782833847.165 sable_ircd #x1B[2m2026-06-30T15:37:27.165396Z#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 synchronize631.388480574" 1782833848.166 chkSvs: waiting… 1782833848.170 sable_ircd #x1B[2m2026-06-30T15:37:28.169847Z#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 1782833848.170 sable_ircd #x1B[2m2026-06-30T15:37:28.169971Z#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)) 1782833848.170 sable_ircd #x1B[2m2026-06-30T15:37:28.170005Z#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) 1782833848.170 S -> chkSvs: ERROR :Client quit 1782833848.170 sable_ircd #x1B[2m2026-06-30T15:37:28.170231Z#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(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 859819926691516418, 99 => 859819926985519106) my clock=EventClock(1 => 859819926691516418, 99 => 859819926985519106) 1782833848.170 chkSvs: disconnects from server. 1782833848.171 sable_ircd #x1B[2m2026-06-30T15:37:28.170478Z#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 1782833848.171 sable_ircd #x1B[2m2026-06-30T15:37:28.170574Z#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 1782833848.171 1: connects to server. 1782833848.171 1 -> S: NICK alys-cef6bd8b0d 1782833848.171 1 -> S: USER r e g :user 1782833848.171 sable_ircd #x1B[2m2026-06-30T15:37:28.170856Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), 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:59425 (127.0.0.1:59425) 1782833848.171 sable_ircd #x1B[2m2026-06-30T15:37:28.171119Z#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 } 1782833848.171 sable_ircd #x1B[2m2026-06-30T15:37:28.171220Z#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 1782833848.171 sable_ircd #x1B[2m2026-06-30T15:37:28.171273Z#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 1782833848.171 sable_ircd #x1B[2m2026-06-30T15:37:28.171338Z#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 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.171580Z#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 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.171631Z#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 alys-cef6bd8b0d" 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.171764Z#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: 632, tv_nsec: 394969214 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("alys-cef6bd8b0d")), 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 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.171839Z#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 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.171898Z#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 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.171939Z#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" 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.172024Z#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: 632, tv_nsec: 394969214 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("alys-cef6bd8b0d")), 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 1782833848.172 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.172243Z#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 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.172280Z#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")) 1782833848.172 sable_ircd #x1B[2m2026-06-30T15:37:28.172319Z#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 1782833848.173 sable_ircd #x1B[2m2026-06-30T15:37:28.172375Z#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: 632, tv_nsec: 394969214 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("alys-cef6bd8b0d")), 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 1782833848.173 sable_ircd #x1B[2m2026-06-30T15:37:28.172444Z#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)) 1782833848.173 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1782833848.173 sable_ircd #x1B[2m2026-06-30T15:37:28.173114Z#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(859819939140210692)), timestamp: 1782833848, clock: EventClock(1 => 859819939127627779, 99 => 859819926985519106), target: User(UserId(Snowflake(859819926691516416))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 859819939127627779, 99 => 859819926985519106) my clock=EventClock(1 => 859819939127627779, 99 => 859819926985519106) 1782833848.174 sable_ircd #x1B[2m2026-06-30T15:37:28.173417Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939140210692)), timestamp: 1782833848, clock: EventClock(1 => 859819939127627779, 99 => 859819926985519106), target: User(UserId(Snowflake(859819926691516416))), 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:59425 (127.0.0.1:59425) 1782833848.174 sable_ircd #x1B[2m2026-06-30T15:37:28.173564Z#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(859819939127627779)), timestamp: 1782833848, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(859819926691516416)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(859819926691516417)), user: UserId(Snowflake(859819926691516416)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833845 } }), users_to_notify: [] }) 1782833848.174 sable_ircd #x1B[2m2026-06-30T15:37:28.173610Z#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(859819939127627779)), timestamp: 1782833848, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(859819926691516416)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(859819926691516417)), user: UserId(Snowflake(859819926691516416)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833845 } }), users_to_notify: [] } 1782833848.174 sable_ircd #x1B[2m2026-06-30T15:37:28.173677Z#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(859819939127627779)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833848.174 sable_ircd #x1B[2m2026-06-30T15:37:28.173711Z#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(859819939127627779)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] } 1782833848.177 sable_ircd #x1B[2m2026-06-30T15:37:28.176885Z#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(859819939152793605)), timestamp: 1782833848, clock: EventClock(1 => 859819939140210692, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: NewUser(NewUser { nickname: Nickname("alys-cef6bd8b0d"), 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(859819939136016387)), NewUserConnection { user: UserId(Snowflake(859819939136016386)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833848 })) }) }; event clock=EventClock(1 => 859819939140210692, 99 => 859819926985519106) my clock=EventClock(1 => 859819939140210692, 99 => 859819926985519106) 1782833848.178 sable_ircd #x1B[2m2026-06-30T15:37:28.177437Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939152793605)), timestamp: 1782833848, clock: EventClock(1 => 859819939140210692, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: NewUser(NewUser { nickname: Nickname("alys-cef6bd8b0d"), 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(859819939136016387)), NewUserConnection { user: UserId(Snowflake(859819939136016386)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833848 })) }) }) } #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:59425 (127.0.0.1:59425) 1782833848.178 sable_services #x1B[2m2026-06-30T15:37:28.177941Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939140210692)), timestamp: 1782833848, clock: EventClock(1 => 859819939127627779, 99 => 859819926985519106), target: User(UserId(Snowflake(859819926691516416))), 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(859819939140210692)), timestamp: 1782833848, clock: EventClock(1 => 859819939127627779, 99 => 859819926985519106), target: User(UserId(Snowflake(859819926691516416))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 859819939127627779, 99 => 859819926985519106) my clock=EventClock(1 => 859819926691516418, 99 => 859819926985519106) 1782833848.178 sable_services #x1B[2m2026-06-30T15:37:28.178027Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939140210692)), timestamp: 1782833848, clock: EventClock(1 => 859819939127627779, 99 => 859819926985519106), target: User(UserId(Snowflake(859819926691516416))), 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(859819939127627779))] 1782833848.179 sable_services #x1B[2m2026-06-30T15:37:28.178465Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939140210692)), timestamp: 1782833848, clock: EventClock(1 => 859819939127627779, 99 => 859819926985519106), target: User(UserId(Snowflake(859819926691516416))), 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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939140210692)), timestamp: 1782833848, clock: EventClock(1 => 859819939127627779, 99 => 859819926985519106), target: User(UserId(Snowflake(859819926691516416))), 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:38021 (127.0.0.1:38021) 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.179654Z#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(859819939140210692)), timestamp: 1782833848, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(859819926691516416)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.179730Z#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(859819939140210692)), timestamp: 1782833848, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(859819926691516416)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.179812Z#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(859819939140210692)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.179850Z#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(859819939140210692)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] } 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.179906Z#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(859819939152793605)), timestamp: 1782833848, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 1) }), users_to_notify: [] }) 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.179936Z#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(859819939152793605)), timestamp: 1782833848, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 1) }), users_to_notify: [] } 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.179978Z#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(859819939152793605)), timestamp: 1782833848, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 2), connection: UserConnectionId(Snowflake(859819939136016387)) }), users_to_notify: [] }) 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180008Z#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(859819939152793605)), timestamp: 1782833848, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 2), connection: UserConnectionId(Snowflake(859819939136016387)) }), users_to_notify: [] } 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180063Z#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 alys-cef6bd8b0d :Welcome to the test Internet Relay Chat network, alys-cef6bd8b0d 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180097Z#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 alys-cef6bd8b0d :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180127Z#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 alys-cef6bd8b0d :This server was created 2026-06-30 15:37:28.180116589 UTC 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180152Z#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 alys-cef6bd8b0d My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180178Z#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 alys-cef6bd8b0d 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 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180210Z#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 alys-cef6bd8b0d :MOTD File is missing 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180239Z#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): :alys-cef6bd8b0d!r@localhost MODE alys-cef6bd8b0d + 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180267Z#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 alys-cef6bd8b0d :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180334Z#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(859819939152793605)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833848.180 sable_ircd #x1B[2m2026-06-30T15:37:28.180401Z#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(859819939152793605)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] } 1782833848.181 S -> 1: :My.Little.Server 001 alys-cef6bd8b0d :Welcome to the test Internet Relay Chat network, alys-cef6bd8b0d 1782833848.181 S -> 1: :My.Little.Server 002 alys-cef6bd8b0d :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1782833848.181 S -> 1: :My.Little.Server 003 alys-cef6bd8b0d :This server was created 2026-06-30 15:37:28.180116589 UTC 1782833848.181 S -> 1: :My.Little.Server 004 alys-cef6bd8b0d My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1782833848.181 S -> 1: :My.Little.Server 005 alys-cef6bd8b0d 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 1782833848.181 S -> 1: :My.Little.Server 422 alys-cef6bd8b0d :MOTD File is missing 1782833848.181 S -> 1: :alys-cef6bd8b0d!r@localhost MODE alys-cef6bd8b0d + 1782833848.181 S -> 1: :My.Little.Server NOTICE alys-cef6bd8b0d :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1782833848.214 sable_services #x1B[2m2026-06-30T15:37:28.213677Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), 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(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 859819926691516418, 99 => 859819926985519106) my clock=EventClock(1 => 859819926691516418, 99 => 859819926985519106) 1782833848.214 sable_services #x1B[2m2026-06-30T15:37:28.213761Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), 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(859819939140210692)), timestamp: 1782833848, clock: EventClock(1 => 859819939127627779, 99 => 859819926985519106), target: User(UserId(Snowflake(859819926691516416))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1782833848.214 sable_services #x1B[2m2026-06-30T15:37:28.214100Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), 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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), 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:38021 (127.0.0.1:38021) 1782833848.220 sable_ircd #x1B[2m2026-06-30T15:37:28.219540Z#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), 1782833845), content: GetEvent([EventId(Snowflake(859819939127627779))]) } }#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(859819939127627779))] 1782833848.220 sable_ircd #x1B[2m2026-06-30T15:37:28.219580Z#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), 1782833845), content: GetEvent([EventId(Snowflake(859819939127627779))]) } }#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(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), details: UserDisconnect(UserDisconnect) }] 1782833848.221 sable_services #x1B[2m2026-06-30T15:37:28.220640Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939152793605)), timestamp: 1782833848, clock: EventClock(1 => 859819939140210692, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: NewUser(NewUser { nickname: Nickname("alys-cef6bd8b0d"), 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(859819939136016387)), NewUserConnection { user: UserId(Snowflake(859819939136016386)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833848 })) }) }) } }#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(859819939152793605)), timestamp: 1782833848, clock: EventClock(1 => 859819939140210692, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: NewUser(NewUser { nickname: Nickname("alys-cef6bd8b0d"), 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(859819939136016387)), NewUserConnection { user: UserId(Snowflake(859819939136016386)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833848 })) }) }; event clock=EventClock(1 => 859819939140210692, 99 => 859819926985519106) my clock=EventClock(1 => 859819939140210692, 99 => 859819926985519106) 1782833848.221 sable_services #x1B[2m2026-06-30T15:37:28.220883Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939152793605)), timestamp: 1782833848, clock: EventClock(1 => 859819939140210692, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: NewUser(NewUser { nickname: Nickname("alys-cef6bd8b0d"), 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(859819939136016387)), NewUserConnection { user: UserId(Snowflake(859819939136016386)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833848 })) }) }) } }#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939152793605)), timestamp: 1782833848, clock: EventClock(1 => 859819939140210692, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: NewUser(NewUser { nickname: Nickname("alys-cef6bd8b0d"), 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(859819939136016387)), NewUserConnection { user: UserId(Snowflake(859819939136016386)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833848 })) }) }) } #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:38021 (127.0.0.1:38021) 1782833848.261 sable_services #x1B[2m2026-06-30T15:37:28.260648Z#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), 1782833845), content: BulkEvents([Event { id: EventId(Snowflake(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), 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(859819939127627779)), timestamp: 1782833848, clock: EventClock(1 => 859819926691516418, 99 => 859819926985519106), target: UserConnection(UserConnectionId(Snowflake(859819926691516417))), details: UserDisconnect(UserDisconnect) }] 1782833848.281 1 -> S: PING synchronize632.504652835 1782833848.282 sable_ircd #x1B[2m2026-06-30T15:37:28.281532Z#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 1782833848.282 sable_ircd #x1B[2m2026-06-30T15:37:28.281591Z#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 synchronize632.504652835" 1782833848.282 sable_ircd #x1B[2m2026-06-30T15:37:28.281702Z#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 :synchronize632.504652835 1782833848.282 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize632.504652835 1782833848.282 1 -> S: REGISTER * * pw-72225dd6e5 1782833848.282 sable_ircd #x1B[2m2026-06-30T15:37:28.282299Z#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 1782833848.282 sable_ircd #x1B[2m2026-06-30T15:37:28.282338Z#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 * * pw-72225dd6e5" 1782833848.283 sable_ircd #x1B[2m2026-06-30T15:37:28.282551Z#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:59425", fingerprint: "b78e56aeae4ac486f6b885107f280c09de617a66" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("alys-cef6bd8b0d"), "pw-72225dd6e5")) } 1782833848.283 sable_ircd #x1B[2m2026-06-30T15:37:28.282765Z#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), 1782833845), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("alys-cef6bd8b0d"), "pw-72225dd6e5")) }) } #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:59425 (127.0.0.1:59425) 1782833848.285 sable_ircd #x1B[2m2026-06-30T15:37:28.284529Z#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) }) 1782833848.326 sable_services #x1B[2m2026-06-30T15:37:28.325749Z#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("alys-cef6bd8b0d"), "pw-72225dd6e5")) 1782833848.326 sable_services #x1B[2m2026-06-30T15:37:28.325793Z#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("alys-cef6bd8b0d") 1782833848.330 sable_services #x1B[2m2026-06-30T15:37:28.329908Z#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(859819939778146304)), name: Nickname("alys-cef6bd8b0d"), authorised_fingerprints: [] } 1782833848.330 sable_services #x1B[2m2026-06-30T15:37:28.330062Z#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(859819939799117827)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: Account(AccountId(Snowflake(859819939778146304))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(859819939778146304)), name: Nickname("alys-cef6bd8b0d"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 859819939152793605, 99 => 859819926985519106) my clock=EventClock(1 => 859819939152793605, 99 => 859819926985519106) 1782833848.330 sable_services #x1B[2m2026-06-30T15:37:28.330342Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939799117827)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: Account(AccountId(Snowflake(859819939778146304))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(859819939778146304)), name: Nickname("alys-cef6bd8b0d"), 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:38021 (127.0.0.1:38021) 1782833848.372 sable_ircd #x1B[2m2026-06-30T15:37:28.371612Z#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), 1782833845), content: TargetedMessageResponse(Services(LogUserIn(AccountId(Snowflake(859819939778146304))))) } } 1782833848.372 sable_ircd #x1B[2m2026-06-30T15:37:28.371926Z#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 alys-cef6bd8b0d :You have successfully registered 1782833848.372 sable_ircd #x1B[2m2026-06-30T15:37:28.371997Z#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 1782833848.372 sable_ircd #x1B[2m2026-06-30T15:37:28.372050Z#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(859819939136016386))), UserLogin(UserLogin { account: Some(AccountId(Snowflake(859819939778146304))) })) 1782833848.373 sable_ircd #x1B[2m2026-06-30T15:37:28.372331Z#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(859819939974877190)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(859819939778146304))) }) }; event clock=EventClock(1 => 859819939152793605, 99 => 859819926985519106) my clock=EventClock(1 => 859819939152793605, 99 => 859819926985519106) 1782833848.373 sable_ircd #x1B[2m2026-06-30T15:37:28.372702Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939974877190)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(859819939778146304))) }) }) } #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:59425 (127.0.0.1:59425) 1782833848.375 sable_ircd #x1B[2m2026-06-30T15:37:28.375176Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939799117827)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: Account(AccountId(Snowflake(859819939778146304))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(859819939778146304)), name: Nickname("alys-cef6bd8b0d"), 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(859819939799117827)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: Account(AccountId(Snowflake(859819939778146304))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(859819939778146304)), name: Nickname("alys-cef6bd8b0d"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 859819939152793605, 99 => 859819926985519106) my clock=EventClock(1 => 859819939974877190, 99 => 859819926985519106) 1782833848.376 sable_ircd #x1B[2m2026-06-30T15:37:28.376068Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939799117827)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: Account(AccountId(Snowflake(859819939778146304))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(859819939778146304)), name: Nickname("alys-cef6bd8b0d"), 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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939799117827)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: Account(AccountId(Snowflake(859819939778146304))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(859819939778146304)), name: Nickname("alys-cef6bd8b0d"), 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:59425 (127.0.0.1:59425) 1782833848.380 sable_ircd #x1B[2m2026-06-30T15:37:28.379826Z#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(859819939974877190)), timestamp: 1782833848, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 3), old_account: None, new_account: Some(AccountId(Snowflake(859819939778146304))) }), users_to_notify: [] }) 1782833848.380 sable_ircd #x1B[2m2026-06-30T15:37:28.379873Z#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(859819939974877190)), timestamp: 1782833848, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 3), old_account: None, new_account: Some(AccountId(Snowflake(859819939778146304))) }), users_to_notify: [] } 1782833848.380 sable_ircd #x1B[2m2026-06-30T15:37:28.379931Z#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(859819939974877190)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833848.380 sable_ircd #x1B[2m2026-06-30T15:37:28.379958Z#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(859819939974877190)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] } 1782833848.380 sable_ircd #x1B[2m2026-06-30T15:37:28.379986Z#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(859819939799117827)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833848.380 sable_ircd #x1B[2m2026-06-30T15:37:28.380004Z#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(859819939799117827)), timestamp: 1782833848, change: EventComplete(EventComplete), users_to_notify: [] } 1782833848.417 sable_services #x1B[2m2026-06-30T15:37:28.416646Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939974877190)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(859819939778146304))) }) }) } }#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(859819939974877190)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(859819939778146304))) }) }; event clock=EventClock(1 => 859819939152793605, 99 => 859819926985519106) my clock=EventClock(1 => 859819939152793605, 99 => 859819939799117827) 1782833848.417 sable_services #x1B[2m2026-06-30T15:37:28.416927Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939974877190)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(859819939778146304))) }) }) } }#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819939974877190)), timestamp: 1782833848, clock: EventClock(1 => 859819939152793605, 99 => 859819926985519106), target: User(UserId(Snowflake(859819939136016386))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(859819939778146304))) }) }) } #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:38021 (127.0.0.1:38021) 1782833848.482 1 -> S: PING synchronize632.705874181 1782833848.482 S -> 1: REGISTER SUCCESS alys-cef6bd8b0d :You have successfully registered 1782833848.483 sable_ircd #x1B[2m2026-06-30T15:37:28.482592Z#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 1782833848.483 sable_ircd #x1B[2m2026-06-30T15:37:28.482635Z#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 synchronize632.705874181" 1782833849.236 sable_ircd #x1B[2m2026-06-30T15:37:29.236309Z#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 :synchronize632.705874181 1782833849.237 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize632.705874181 1782833849.237 1 -> S: QUIT 1782833849.237 sable_ircd #x1B[2m2026-06-30T15:37:29.237038Z#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 1782833849.237 sable_ircd #x1B[2m2026-06-30T15:37:29.237092Z#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" 1782833849.337 1 -> S: PING synchronize633.560535604 1782833849.337 sable_ircd #x1B[2m2026-06-30T15:37:29.337259Z#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 1782833849.337 sable_ircd #x1B[2m2026-06-30T15:37:29.337319Z#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 synchronize633.560535604" 1782833850.091 sable_ircd #x1B[2m2026-06-30T15:37:30.091205Z#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 1782833850.091 sable_ircd #x1B[2m2026-06-30T15:37:30.091386Z#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)) 1782833850.091 sable_ircd #x1B[2m2026-06-30T15:37:30.091430Z#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) 1782833850.092 S -> 1: ERROR :Client quit 1782833850.092 sable_ircd #x1B[2m2026-06-30T15:37:30.091591Z#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(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 859819939974877190, 99 => 859819939799117827) my clock=EventClock(1 => 859819939974877190, 99 => 859819939799117827) 1782833850.092 sable_ircd #x1B[2m2026-06-30T15:37:30.091952Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), 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:59425 (127.0.0.1:59425) 1782833850.092 sable_ircd #x1B[2m2026-06-30T15:37:30.091962Z#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 1782833850.092 sable_ircd #x1B[2m2026-06-30T15:37:30.092036Z#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 1782833850.094 sable_ircd #x1B[2m2026-06-30T15:37:30.094258Z#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(859819947197468680)), timestamp: 1782833850, clock: EventClock(1 => 859819947184885767, 99 => 859819939799117827), target: User(UserId(Snowflake(859819939136016386))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 859819947184885767, 99 => 859819939799117827) my clock=EventClock(1 => 859819947184885767, 99 => 859819939799117827) 1782833850.095 sable_ircd #x1B[2m2026-06-30T15:37:30.094609Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947197468680)), timestamp: 1782833850, clock: EventClock(1 => 859819947184885767, 99 => 859819939799117827), target: User(UserId(Snowflake(859819939136016386))), 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:59425 (127.0.0.1:59425) 1782833850.095 sable_ircd #x1B[2m2026-06-30T15:37:30.094728Z#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(859819947184885767)), timestamp: 1782833850, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(859819939136016387)), user: UserId(Snowflake(859819939136016386)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833848 } }), users_to_notify: [] }) 1782833850.095 sable_ircd #x1B[2m2026-06-30T15:37:30.094959Z#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(859819947184885767)), timestamp: 1782833850, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(859819939136016387)), user: UserId(Snowflake(859819939136016386)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833848 } }), users_to_notify: [] } 1782833850.095 sable_ircd #x1B[2m2026-06-30T15:37:30.095041Z#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(859819947184885767)), timestamp: 1782833850, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833850.095 sable_ircd #x1B[2m2026-06-30T15:37:30.095081Z#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(859819947184885767)), timestamp: 1782833850, change: EventComplete(EventComplete), users_to_notify: [] } 1782833850.099 sable_ircd #x1B[2m2026-06-30T15:37:30.098444Z#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(859819947197468680)), timestamp: 1782833850, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 3), nickname: Nickname("alys-cef6bd8b0d"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1782833850.099 sable_ircd #x1B[2m2026-06-30T15:37:30.098495Z#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(859819947197468680)), timestamp: 1782833850, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(859819939136016386)), 3), nickname: Nickname("alys-cef6bd8b0d"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1782833850.099 sable_ircd #x1B[2m2026-06-30T15:37:30.098560Z#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(859819947197468680)), timestamp: 1782833850, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833850.099 sable_ircd #x1B[2m2026-06-30T15:37:30.098603Z#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(859819947197468680)), timestamp: 1782833850, change: EventComplete(EventComplete), users_to_notify: [] } 1782833850.099 sable_services #x1B[2m2026-06-30T15:37:30.099061Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947197468680)), timestamp: 1782833850, clock: EventClock(1 => 859819947184885767, 99 => 859819939799117827), target: User(UserId(Snowflake(859819939136016386))), 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(859819947197468680)), timestamp: 1782833850, clock: EventClock(1 => 859819947184885767, 99 => 859819939799117827), target: User(UserId(Snowflake(859819939136016386))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 859819947184885767, 99 => 859819939799117827) my clock=EventClock(1 => 859819939974877190, 99 => 859819939799117827) 1782833850.099 sable_services #x1B[2m2026-06-30T15:37:30.099128Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947197468680)), timestamp: 1782833850, clock: EventClock(1 => 859819947184885767, 99 => 859819939799117827), target: User(UserId(Snowflake(859819939136016386))), 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(859819947184885767))] 1782833850.100 sable_services #x1B[2m2026-06-30T15:37:30.099486Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947197468680)), timestamp: 1782833850, clock: EventClock(1 => 859819947184885767, 99 => 859819939799117827), target: User(UserId(Snowflake(859819939136016386))), 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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947197468680)), timestamp: 1782833850, clock: EventClock(1 => 859819947184885767, 99 => 859819939799117827), target: User(UserId(Snowflake(859819939136016386))), 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:38021 (127.0.0.1:38021) 1782833850.136 sable_services #x1B[2m2026-06-30T15:37:30.135802Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), 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(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 859819939974877190, 99 => 859819939799117827) my clock=EventClock(1 => 859819939974877190, 99 => 859819939799117827) 1782833850.136 sable_services #x1B[2m2026-06-30T15:37:30.135881Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), 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(859819947197468680)), timestamp: 1782833850, clock: EventClock(1 => 859819947184885767, 99 => 859819939799117827), target: User(UserId(Snowflake(859819939136016386))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1782833850.136 sable_services #x1B[2m2026-06-30T15:37:30.136223Z#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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), 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), 1782833845), content: NewEvent(Event { id: EventId(Snowflake(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), 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:38021 (127.0.0.1:38021) 1782833850.141 sable_ircd #x1B[2m2026-06-30T15:37:30.140573Z#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), 1782833845), content: GetEvent([EventId(Snowflake(859819947184885767))]) } }#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(859819947184885767))] 1782833850.141 sable_ircd #x1B[2m2026-06-30T15:37:30.140619Z#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), 1782833845), content: GetEvent([EventId(Snowflake(859819947184885767))]) } }#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(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), details: UserDisconnect(UserDisconnect) }] 1782833850.183 sable_services #x1B[2m2026-06-30T15:37:30.182611Z#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), 1782833845), content: BulkEvents([Event { id: EventId(Snowflake(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), 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(859819947184885767)), timestamp: 1782833850, clock: EventClock(1 => 859819939974877190, 99 => 859819939799117827), target: UserConnection(UserConnectionId(Snowflake(859819939136016387))), details: UserDisconnect(UserDisconnect) }] 1782833850.192 1 -> S: PING synchronize634.415525729 1782833850.192 1: connects to server. 1782833850.192 1 -> S: CAP LS 302 1782833850.193 sable_ircd #x1B[2m2026-06-30T15:37:30.192756Z#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 } 1782833850.193 sable_ircd #x1B[2m2026-06-30T15:37:30.192854Z#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 1782833850.193 sable_ircd #x1B[2m2026-06-30T15:37:30.192907Z#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 1782833850.193 sable_ircd #x1B[2m2026-06-30T15:37:30.192989Z#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 1782833850.193 sable_ircd #x1B[2m2026-06-30T15:37:30.193245Z#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 1782833850.193 sable_ircd #x1B[2m2026-06-30T15:37:30.193311Z#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" 1782833850.194 sable_ircd #x1B[2m2026-06-30T15:37:30.193462Z#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 1782833850.194 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1782833850.194 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 1782833850.194 sable_ircd #x1B[2m2026-06-30T15:37:30.193942Z#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 1782833850.194 1 -> S: CAP REQ :draft/read-marker sasl 1782833850.194 sable_ircd #x1B[2m2026-06-30T15:37:30.193974Z#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")) 1782833850.194 sable_ircd #x1B[2m2026-06-30T15:37:30.193999Z#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 1782833850.194 sable_ircd #x1B[2m2026-06-30T15:37:30.194020Z#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: 634, tv_nsec: 416610042 }, 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 1782833850.194 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1782833850.194 sable_ircd #x1B[2m2026-06-30T15:37:30.194307Z#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 1782833850.194 sable_ircd #x1B[2m2026-06-30T15:37:30.194348Z#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 :draft/read-marker sasl" 1782833850.194 sable_ircd #x1B[2m2026-06-30T15:37:30.194459Z#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 * NAK :draft/read-marker sasl 1782833850.234 S -> 1: :My.Little.Server CAP * NAK :draft/read-marker sasl 1782833850.237 sable_ircd #x1B[2m2026-06-30T15:37:30.237101Z#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 1782833850.237 sable_ircd #x1B[2m2026-06-30T15:37:30.237303Z#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:38021, peer: 127.0.0.1:38381, fd: 19 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x5606d68d8010, 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 1782833850.242 1: disconnects from server.