--------------------------------- Captured Out --------------------------------- ---- new test ---- 1788127839.393 sable_services uid=1001 1788127839.394 sable_services #x1B[2m2026-08-30T22:10:39.393495Z#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:35529", fingerprint: "632c48b85246dd3de1a95c6c3bdfd37764ed09b3" } 1788127839.394 sable_ircd uid=1001 1788127839.394 sable_services #x1B[2m2026-08-30T22:10:39.393700Z#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), 1788127839), 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:35529. Last error: I/O error: Connection refused (os error 111) 1788127839.394 sable_services #x1B[2m2026-08-30T22:10:39.393738Z#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), 1788127839), 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) 1788127839.396 sable_ircd #x1B[2m2026-08-30T22:10:39.395714Z#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(882024547698610176)), timestamp: 1788127839, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127839, name: ServerName("My.Little.Server"), ts: 1788127839, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1788127839.396 sable_ircd #x1B[2m2026-08-30T22:10:39.395816Z#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 1788127839.396 sable_ircd #x1B[2m2026-08-30T22:10:39.395990Z#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(882024547698610176)), timestamp: 1788127839, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127839, name: ServerName("My.Little.Server"), ts: 1788127839, 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 1788127839.396 sable_ircd #x1B[2m2026-08-30T22:10:39.396135Z#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(882024547698610176)), timestamp: 1788127839, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1788127839.396 sable_ircd #x1B[2m2026-08-30T22:10:39.396167Z#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(882024547698610176)), timestamp: 1788127839, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1788127839.396 sable_ircd #x1B[2m2026-08-30T22:10:39.396213Z#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(882024547698610176)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127839.396 sable_ircd #x1B[2m2026-08-30T22:10:39.396236Z#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(882024547698610176)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] } 1788127839.397 sable_ircd #x1B[2m2026-08-30T22:10:39.396443Z#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 1788127839.397 sable_ircd #x1B[2m2026-08-30T22:10:39.396527Z#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(882024547702804481)), timestamp: 1788127839, clock: EventClock(1 => 882024547698610176), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127839 }) }; event clock=EventClock(1 => 882024547698610176) my clock=EventClock(1 => 882024547698610176) 1788127839.397 sable_ircd #x1B[2m2026-08-30T22:10:39.396574Z#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 1788127839.397 sable_ircd #x1B[2m2026-08-30T22:10:39.396744Z#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(882024547702804481)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127839.397 sable_ircd #x1B[2m2026-08-30T22:10:39.396770Z#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(882024547702804481)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] } 1788127839.490 sable_ircd #x1B[2m2026-08-30T22:10:39.489760Z#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 } 1788127839.490 sable_ircd #x1B[2m2026-08-30T22:10:39.489887Z#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 1788127839.490 sable_ircd #x1B[2m2026-08-30T22:10:39.489930Z#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 1788127839.490 sable_ircd #x1B[2m2026-08-30T22:10:39.490001Z#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 1788127839.490 sable_ircd #x1B[2m2026-08-30T22:10:39.490133Z#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 1788127839.490 sable_ircd #x1B[2m2026-08-30T22:10:39.490180Z#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" 1788127839.490 sable_ircd #x1B[2m2026-08-30T22:10:39.490274Z#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 1788127839.490 sable_ircd #x1B[2m2026-08-30T22:10:39.490342Z#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)) 1788127839.490 sable_ircd #x1B[2m2026-08-30T22:10:39.490365Z#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) 1788127839.491 sable_ircd #x1B[2m2026-08-30T22:10:39.490694Z#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 1788127839.491 sable_ircd #x1B[2m2026-08-30T22:10:39.490762Z#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 1788127839.491 sable_ircd #x1B[2m2026-08-30T22:10:39.490928Z#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 1788127839.499 sable_services #x1B[2m2026-08-30T22:10:39.499204Z#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:35529", fingerprint: "632c48b85246dd3de1a95c6c3bdfd37764ed09b3" } 1788127839.499 sable_services #x1B[2m2026-08-30T22:10:39.499433Z#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), 1788127839), 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:35529 (127.0.0.1:35529) 1788127839.503 sable_ircd #x1B[2m2026-08-30T22:10:39.503190Z#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 1788127839.511 chkSvs: connects to server. 1788127839.511 chkSvs -> S: NICK chkSvs 1788127839.511 chkSvs -> S: USER chk chk chk chk 1788127839.511 sable_ircd #x1B[2m2026-08-30T22:10:39.510954Z#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 } 1788127839.511 sable_ircd #x1B[2m2026-08-30T22:10:39.511042Z#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 1788127839.511 sable_ircd #x1B[2m2026-08-30T22:10:39.511069Z#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 1788127839.511 sable_ircd #x1B[2m2026-08-30T22:10:39.511104Z#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 1788127839.511 sable_ircd #x1B[2m2026-08-30T22:10:39.511174Z#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 1788127839.511 sable_ircd #x1B[2m2026-08-30T22:10:39.511199Z#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" 1788127839.511 sable_ircd #x1B[2m2026-08-30T22:10:39.511275Z#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 1788127839.511 sable_ircd #x1B[2m2026-08-30T22:10:39.511312Z#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" 1788127839.511 sable_ircd #x1B[2m2026-08-30T22:10:39.511377Z#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: 485, tv_nsec: 632710803 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(), 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 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.511488Z#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: 485, tv_nsec: 632710803 }, 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 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.511532Z#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 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.511873Z#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 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.511900Z#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")) 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.511920Z#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 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.511936Z#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: 485, tv_nsec: 632710803 }, 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 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.511966Z#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)) 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.512122Z#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(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }; event clock=EventClock(1 => 882024547702804481) my clock=EventClock(1 => 882024547702804481) 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.512208Z#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 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.512421Z#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(882024548189343746)), timestamp: 1788127839, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024548189343744)), 1) }), users_to_notify: [] }) 1788127839.512 sable_ircd #x1B[2m2026-08-30T22:10:39.512451Z#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(882024548189343746)), timestamp: 1788127839, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024548189343744)), 1) }), users_to_notify: [] } 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512486Z#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(882024548189343746)), timestamp: 1788127839, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024548189343744)), 2), connection: UserConnectionId(Snowflake(882024548189343745)) }), users_to_notify: [] }) 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512500Z#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(882024548189343746)), timestamp: 1788127839, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024548189343744)), 2), connection: UserConnectionId(Snowflake(882024548189343745)) }), users_to_notify: [] } 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512533Z#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 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512549Z#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 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512565Z#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-08-30 22:10:39.512558166 UTC 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512576Z#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 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512599Z#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 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512611Z#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 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512623Z#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 + 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512633Z#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. 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512647Z#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(882024548189343746)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127839.513 sable_ircd #x1B[2m2026-08-30T22:10:39.512659Z#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(882024548189343746)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] } 1788127839.545 sable_services #x1B[2m2026-08-30T22:10:39.544998Z#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), 1788127839), content: NetworkState(Network { nick_bindings: {}, historic_nick_users: HistoricNickStore { data: {} }, users: {}, historic_users: HistoricUserStore { users: {} }, user_connections: {}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1788127839, name: ServerName("My.Little.Server"), last_ping: 1788127839, 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: {"tls": (0, Boolean(_)), "ip": (0, Ip(_)), "user_param_2": (2, String(_)), "realname": (3, String(_)), "user": (5, String(_)), "nick": (0, String(_)), "user_param_1": (1, String(_)), "host": (4, String(_))} }, 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: {"ip": (0, Ip(_)), "tls": (0, Boolean(_))} }, 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(_)), "tls": (0, Boolean(_)), "mechanism": (0, String(_))} } }, 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 => 882024547702804481), cache_default_channel_roles: OnceLock(), alias_users: OnceLock() }) } 1788127839.545 sable_services #x1B[2m2026-08-30T22:10:39.545141Z#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 1788127839.545 sable_services #x1B[2m2026-08-30T22:10:39.545228Z#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 1788127839.546 sable_services #x1B[2m2026-08-30T22:10:39.545636Z#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(882024548328157184)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127839, name: ServerName("My.Little.Services"), ts: 1788127839, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 882024547702804481) my clock=EventClock(1 => 882024547702804481) 1788127839.546 sable_services #x1B[2m2026-08-30T22:10:39.545927Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548328157184)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127839, name: ServerName("My.Little.Services"), ts: 1788127839, 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:35529 (127.0.0.1:35529) 1788127839.547 sable_services #x1B[2m2026-08-30T22:10:39.547376Z#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(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }; event clock=EventClock(1 => 882024547702804481, 99 => 882024548328157184) my clock=EventClock(1 => 882024547702804481, 99 => 882024548328157184) 1788127839.548 sable_services #x1B[2m2026-08-30T22:10:39.547667Z#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(882024548328157184)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127839, name: ServerName("My.Little.Services"), ts: 1788127839, 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 1788127839.548 sable_services #x1B[2m2026-08-30T22:10:39.547965Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }) } #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:35529 (127.0.0.1:35529) 1788127839.549 sable_services #x1B[2m2026-08-30T22:10:39.549238Z#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(882024548344934402)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548336545793), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 882024547702804481, 99 => 882024548336545793) my clock=EventClock(1 => 882024547702804481, 99 => 882024548336545793) 1788127839.550 sable_services #x1B[2m2026-08-30T22:10:39.549677Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548344934402)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548336545793), 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:35529 (127.0.0.1:35529) 1788127839.553 sable_ircd #x1B[2m2026-08-30T22:10:39.553081Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548344934402)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548336545793), 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 Deferring event Event { id: EventId(Snowflake(882024548344934402)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548336545793), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 882024547702804481, 99 => 882024548336545793) my clock=EventClock(1 => 882024548189343746) 1788127839.553 sable_ircd #x1B[2m2026-08-30T22:10:39.553133Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548344934402)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548336545793), 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::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(882024548336545793))] 1788127839.553 sable_ircd #x1B[2m2026-08-30T22:10:39.553166Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548344934402)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548336545793), 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::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1788127839.589 sable_ircd #x1B[2m2026-08-30T22:10:39.588752Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548328157184)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127839, name: ServerName("My.Little.Services"), ts: 1788127839, 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(882024548328157184)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127839, name: ServerName("My.Little.Services"), ts: 1788127839, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 882024547702804481) my clock=EventClock(1 => 882024548189343746) 1788127839.589 sable_ircd #x1B[2m2026-08-30T22:10:39.588808Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548328157184)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127839, name: ServerName("My.Little.Services"), ts: 1788127839, 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 1788127839.589 sable_ircd #x1B[2m2026-08-30T22:10:39.588970Z#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(882024548328157184)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127839, name: ServerName("My.Little.Services"), ts: 1788127839, 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 1788127839.589 sable_ircd #x1B[2m2026-08-30T22:10:39.589044Z#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(882024548328157184)), timestamp: 1788127839, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }) 1788127839.589 sable_ircd #x1B[2m2026-08-30T22:10:39.589066Z#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(882024548328157184)), timestamp: 1788127839, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] } 1788127839.589 sable_ircd #x1B[2m2026-08-30T22:10:39.589095Z#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(882024548328157184)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127839.589 sable_ircd #x1B[2m2026-08-30T22:10:39.589106Z#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(882024548328157184)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] } 1788127839.590 sable_ircd #x1B[2m2026-08-30T22:10:39.589624Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }) } }#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(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }; event clock=EventClock(1 => 882024547702804481, 99 => 882024548328157184) my clock=EventClock(1 => 882024548189343746, 99 => 882024548328157184) 1788127839.590 sable_ircd #x1B[2m2026-08-30T22:10:39.589682Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }) } }#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(882024548344934402)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548336545793), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) } 1788127839.590 sable_ircd #x1B[2m2026-08-30T22:10:39.589992Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }) } }#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }) } #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:57377 (127.0.0.1:57377) 1788127839.593 sable_ircd #x1B[2m2026-08-30T22:10:39.592927Z#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(882024548336545793)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127839.593 sable_ircd #x1B[2m2026-08-30T22:10:39.592967Z#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(882024548336545793)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] } 1788127839.593 sable_ircd #x1B[2m2026-08-30T22:10:39.593000Z#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(882024548344934402)), timestamp: 1788127839, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }) 1788127839.593 sable_ircd #x1B[2m2026-08-30T22:10:39.593021Z#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(882024548344934402)), timestamp: 1788127839, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] } 1788127839.593 sable_ircd #x1B[2m2026-08-30T22:10:39.593111Z#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(882024548344934402)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127839.593 sable_ircd #x1B[2m2026-08-30T22:10:39.593141Z#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(882024548344934402)), timestamp: 1788127839, change: EventComplete(EventComplete), users_to_notify: [] } 1788127839.594 sable_services #x1B[2m2026-08-30T22:10:39.593603Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024548336545793))]) } }#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(882024548336545793))] 1788127839.594 sable_services #x1B[2m2026-08-30T22:10:39.593634Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024548336545793))]) } }#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(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }] 1788127839.611 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127839.611 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127839.611 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1788127839.611 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127839.611 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2026-08-30 22:10:39.512558166 UTC 1788127839.611 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127839.611 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 1788127839.611 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing 1788127839.611 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs + 1788127839.611 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127839.611 chkSvs -> S: CAP LS 302 1788127839.611 sable_ircd #x1B[2m2026-08-30T22:10:39.611415Z#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 1788127839.611 sable_ircd #x1B[2m2026-08-30T22:10:39.611459Z#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" 1788127839.612 sable_ircd #x1B[2m2026-08-30T22:10:39.611582Z#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 1788127839.635 sable_ircd #x1B[2m2026-08-30T22:10:39.634702Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }]) } }#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(882024548336545793)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481, 99 => 882024548328157184), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127839 }) }] 1788127839.661 chkSvs -> S: PING synchronize485.782755003 1788127839.661 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 1788127839.662 sable_ircd #x1B[2m2026-08-30T22:10:39.661532Z#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 1788127839.662 sable_ircd #x1B[2m2026-08-30T22:10:39.661580Z#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 synchronize485.782755003" 1788127839.662 sable_ircd #x1B[2m2026-08-30T22:10:39.661685Z#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 :synchronize485.782755003 1788127839.662 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize485.782755003 1788127839.662 chkSvs -> S: QUIT 1788127839.662 chkSvs -> S: PING synchronize485.783570418 1788127839.662 sable_ircd #x1B[2m2026-08-30T22:10:39.662121Z#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 1788127839.662 sable_ircd #x1B[2m2026-08-30T22:10:39.662157Z#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" 1788127839.662 sable_ircd #x1B[2m2026-08-30T22:10:39.662218Z#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 1788127839.662 sable_ircd #x1B[2m2026-08-30T22:10:39.662247Z#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 synchronize485.783570418" 1788127840.166 sable_ircd #x1B[2m2026-08-30T22:10:40.165470Z#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 1788127840.166 sable_ircd #x1B[2m2026-08-30T22:10:40.165596Z#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)) 1788127840.166 sable_ircd #x1B[2m2026-08-30T22:10:40.165619Z#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) 1788127840.166 sable_ircd #x1B[2m2026-08-30T22:10:40.165749Z#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(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 882024548189343746, 99 => 882024548344934402) my clock=EventClock(1 => 882024548189343746, 99 => 882024548344934402) 1788127840.166 S -> chkSvs: ERROR :Client quit 1788127840.166 chkSvs: disconnects from server. 1788127840.166 sable_ircd #x1B[2m2026-08-30T22:10:40.165976Z#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 1788127840.166 sable_ircd #x1B[2m2026-08-30T22:10:40.166024Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), 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:57377 (127.0.0.1:57377) 1788127840.166 sable_ircd #x1B[2m2026-08-30T22:10:40.166039Z#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 1788127840.167 1: connects to server. 1788127840.167 1 -> S: NICK foo 1788127840.167 1 -> S: USER r e g :user 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.166704Z#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 } 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.166770Z#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 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.166793Z#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 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.166833Z#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 1788127840.167 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.167101Z#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 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.167142Z#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 foo" 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.167218Z#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 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.167249Z#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" 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.167308Z#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: 486, tv_nsec: 288441273 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(), 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 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.167370Z#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: 486, tv_nsec: 288441273 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("foo")), 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 1788127840.167 sable_ircd #x1B[2m2026-08-30T22:10:40.167423Z#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 1788127840.168 sable_ircd #x1B[2m2026-08-30T22:10:40.167561Z#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 1788127840.168 sable_ircd #x1B[2m2026-08-30T22:10:40.167583Z#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")) 1788127840.168 sable_ircd #x1B[2m2026-08-30T22:10:40.167601Z#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 1788127840.168 sable_ircd #x1B[2m2026-08-30T22:10:40.167614Z#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: 486, tv_nsec: 288441273 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("foo")), 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 1788127840.168 sable_ircd #x1B[2m2026-08-30T22:10:40.167641Z#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)) 1788127840.168 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127840.168 sable_ircd #x1B[2m2026-08-30T22:10:40.168034Z#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(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 882024550928224259, 99 => 882024548344934402) my clock=EventClock(1 => 882024550928224259, 99 => 882024548344934402) 1788127840.168 sable_ircd #x1B[2m2026-08-30T22:10:40.168247Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), 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:57377 (127.0.0.1:57377) 1788127840.171 sable_ircd #x1B[2m2026-08-30T22:10:40.171013Z#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(882024550949195781)), timestamp: 1788127840, clock: EventClock(1 => 882024550940807172, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(882024550936612867)), NewUserConnection { user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 })) }) }; event clock=EventClock(1 => 882024550940807172, 99 => 882024548344934402) my clock=EventClock(1 => 882024550940807172, 99 => 882024548344934402) 1788127840.171 sable_ircd #x1B[2m2026-08-30T22:10:40.171240Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550949195781)), timestamp: 1788127840, clock: EventClock(1 => 882024550940807172, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(882024550936612867)), NewUserConnection { user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 })) }) }) } #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:57377 (127.0.0.1:57377) 1788127840.172 sable_ircd #x1B[2m2026-08-30T22:10:40.171316Z#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(882024550928224259)), timestamp: 1788127840, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(882024548189343744)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(882024548189343745)), user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 } }), users_to_notify: [] }) 1788127840.172 sable_ircd #x1B[2m2026-08-30T22:10:40.171347Z#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(882024550928224259)), timestamp: 1788127840, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(882024548189343744)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(882024548189343745)), user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 } }), users_to_notify: [] } 1788127840.172 sable_ircd #x1B[2m2026-08-30T22:10:40.171408Z#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(882024550928224259)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127840.172 sable_ircd #x1B[2m2026-08-30T22:10:40.171429Z#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(882024550928224259)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] } 1788127840.172 sable_services #x1B[2m2026-08-30T22:10:40.171886Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), 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(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 882024550928224259, 99 => 882024548344934402) my clock=EventClock(1 => 882024547702804481, 99 => 882024548344934402) 1788127840.172 sable_services #x1B[2m2026-08-30T22:10:40.171955Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), 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(882024550928224259))] 1788127840.173 sable_services #x1B[2m2026-08-30T22:10:40.172220Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), 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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), 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:35529 (127.0.0.1:35529) 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173078Z#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(882024550940807172)), timestamp: 1788127840, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(882024548189343744)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173137Z#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(882024550940807172)), timestamp: 1788127840, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(882024548189343744)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173195Z#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(882024550940807172)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173222Z#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(882024550940807172)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] } 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173262Z#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(882024550949195781)), timestamp: 1788127840, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 1) }), users_to_notify: [] }) 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173285Z#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(882024550949195781)), timestamp: 1788127840, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 1) }), users_to_notify: [] } 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173309Z#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(882024550949195781)), timestamp: 1788127840, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 2), connection: UserConnectionId(Snowflake(882024550936612867)) }), users_to_notify: [] }) 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173322Z#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(882024550949195781)), timestamp: 1788127840, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 2), connection: UserConnectionId(Snowflake(882024550936612867)) }), users_to_notify: [] } 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173351Z#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 foo :Welcome to the test Internet Relay Chat network, foo 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173366Z#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 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173398Z#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 foo :This server was created 2026-08-30 22:10:40.173375132 UTC 1788127840.173 sable_ircd #x1B[2m2026-08-30T22:10:40.173417Z#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 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127840.174 sable_ircd #x1B[2m2026-08-30T22:10:40.173431Z#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 foo 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 1788127840.174 sable_ircd #x1B[2m2026-08-30T22:10:40.173442Z#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 foo :MOTD File is missing 1788127840.174 sable_ircd #x1B[2m2026-08-30T22:10:40.173453Z#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): :foo!r@localhost MODE foo + 1788127840.174 sable_ircd #x1B[2m2026-08-30T22:10:40.173461Z#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 foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127840.174 sable_ircd #x1B[2m2026-08-30T22:10:40.173488Z#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(882024550949195781)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127840.174 sable_ircd #x1B[2m2026-08-30T22:10:40.173498Z#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(882024550949195781)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] } 1788127840.174 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo 1788127840.174 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127840.174 S -> 1: :My.Little.Server 003 foo :This server was created 2026-08-30 22:10:40.173375132 UTC 1788127840.174 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127840.174 S -> 1: :My.Little.Server 005 foo 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 1788127840.174 S -> 1: :My.Little.Server 422 foo :MOTD File is missing 1788127840.174 S -> 1: :foo!r@localhost MODE foo + 1788127840.174 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127840.209 sable_services #x1B[2m2026-08-30T22:10:40.208720Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 882024548189343746, 99 => 882024548344934402) my clock=EventClock(1 => 882024547702804481, 99 => 882024548344934402) 1788127840.209 sable_services #x1B[2m2026-08-30T22:10:40.208769Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(882024548189343746))] 1788127840.209 sable_services #x1B[2m2026-08-30T22:10:40.209059Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), 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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), 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:35529 (127.0.0.1:35529) 1788127840.213 sable_ircd #x1B[2m2026-08-30T22:10:40.212538Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024550928224259))]) } }#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(882024550928224259))] 1788127840.213 sable_ircd #x1B[2m2026-08-30T22:10:40.212571Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024550928224259))]) } }#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(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) }] 1788127840.214 sable_services #x1B[2m2026-08-30T22:10:40.213601Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550949195781)), timestamp: 1788127840, clock: EventClock(1 => 882024550940807172, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(882024550936612867)), NewUserConnection { user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 })) }) }) } }#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(882024550949195781)), timestamp: 1788127840, clock: EventClock(1 => 882024550940807172, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(882024550936612867)), NewUserConnection { user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 })) }) }; event clock=EventClock(1 => 882024550940807172, 99 => 882024548344934402) my clock=EventClock(1 => 882024547702804481, 99 => 882024548344934402) 1788127840.214 sable_services #x1B[2m2026-08-30T22:10:40.213649Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550949195781)), timestamp: 1788127840, clock: EventClock(1 => 882024550940807172, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(882024550936612867)), NewUserConnection { user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 })) }) }) } }#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(882024550940807172))] 1788127840.214 sable_services #x1B[2m2026-08-30T22:10:40.213896Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550949195781)), timestamp: 1788127840, clock: EventClock(1 => 882024550940807172, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(882024550936612867)), NewUserConnection { user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 })) }) }) } }#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024550949195781)), timestamp: 1788127840, clock: EventClock(1 => 882024550940807172, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(882024550936612867)), NewUserConnection { user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 })) }) }) } #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:35529 (127.0.0.1:35529) 1788127840.250 sable_ircd #x1B[2m2026-08-30T22:10:40.249614Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024548189343746))]) } }#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(882024548189343746))] 1788127840.250 sable_ircd #x1B[2m2026-08-30T22:10:40.249648Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024548189343746))]) } }#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(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }] 1788127840.254 sable_services #x1B[2m2026-08-30T22:10:40.253596Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), 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(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) }] 1788127840.254 sable_services #x1B[2m2026-08-30T22:10:40.253658Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 882024548189343746, 99 => 882024548344934402) my clock=EventClock(1 => 882024547702804481, 99 => 882024548344934402) 1788127840.254 sable_services #x1B[2m2026-08-30T22:10:40.253721Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(882024548189343746))] 1788127840.255 sable_ircd #x1B[2m2026-08-30T22:10:40.254493Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024550940807172))]) } }#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(882024550940807172))] 1788127840.255 sable_ircd #x1B[2m2026-08-30T22:10:40.254519Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024550940807172))]) } }#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(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1788127840.274 1 -> S: PING synchronize486.395977899 1788127840.275 sable_ircd #x1B[2m2026-08-30T22:10:40.274715Z#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 1788127840.275 sable_ircd #x1B[2m2026-08-30T22:10:40.274755Z#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 synchronize486.395977899" 1788127840.275 sable_ircd #x1B[2m2026-08-30T22:10:40.274854Z#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 :synchronize486.395977899 1788127840.275 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize486.395977899 1788127840.275 1 -> S: REGISTER * * barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar 1788127840.275 sable_ircd #x1B[2m2026-08-30T22:10:40.275264Z#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 1788127840.275 sable_ircd #x1B[2m2026-08-30T22:10:40.275292Z#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 * * barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar" 1788127840.276 sable_ircd #x1B[2m2026-08-30T22:10:40.275464Z#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:57377", fingerprint: "04871fb970265dddc9e6bf9468d18c8c7bf96fca" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("foo"), "barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar")) } 1788127840.276 sable_ircd #x1B[2m2026-08-30T22:10:40.275628Z#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), 1788127839), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("foo"), "barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar")) }) } #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:57377 (127.0.0.1:57377) 1788127840.277 sable_ircd #x1B[2m2026-08-30T22:10:40.276951Z#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) }) 1788127840.291 sable_services #x1B[2m2026-08-30T22:10:40.290645Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }]) } }#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(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }] 1788127840.291 sable_services #x1B[2m2026-08-30T22:10:40.290707Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }; event clock=EventClock(1 => 882024547702804481) my clock=EventClock(1 => 882024547702804481, 99 => 882024548344934402) 1788127840.291 sable_services #x1B[2m2026-08-30T22:10:40.290793Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(882024550928224259)), timestamp: 1788127840, clock: EventClock(1 => 882024548189343746, 99 => 882024548344934402), target: UserConnection(UserConnectionId(Snowflake(882024548189343745))), details: UserDisconnect(UserDisconnect) } 1788127840.291 sable_services #x1B[2m2026-08-30T22:10:40.290831Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1788127840.291 sable_services #x1B[2m2026-08-30T22:10:40.290866Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(882024550949195781)), timestamp: 1788127840, clock: EventClock(1 => 882024550940807172, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(882024550936612867)), NewUserConnection { user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 })) }) } 1788127840.296 sable_services #x1B[2m2026-08-30T22:10:40.295581Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), details: UserQuit(UserQuit { message: "Client Quit" }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(882024550940807172)), timestamp: 1788127840, clock: EventClock(1 => 882024550928224259, 99 => 882024548344934402), target: User(UserId(Snowflake(882024548189343744))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1788127840.318 sable_services #x1B[2m2026-08-30T22:10:40.317650Z#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("foo"), "barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar")) 1788127840.318 sable_services #x1B[2m2026-08-30T22:10:40.317678Z#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("foo") 1788127840.321 sable_services #x1B[2m2026-08-30T22:10:40.321064Z#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(882024551566159872)), name: Nickname("foo"), authorised_fingerprints: [] } 1788127840.321 sable_services #x1B[2m2026-08-30T22:10:40.321206Z#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(882024551582937091)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: Account(AccountId(Snowflake(882024551566159872))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024551566159872)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 882024550949195781, 99 => 882024548344934402) my clock=EventClock(1 => 882024550949195781, 99 => 882024548344934402) 1788127840.321 sable_services #x1B[2m2026-08-30T22:10:40.321431Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024551582937091)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: Account(AccountId(Snowflake(882024551566159872))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024551566159872)), name: Nickname("foo"), 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:35529 (127.0.0.1:35529) 1788127840.363 sable_ircd #x1B[2m2026-08-30T22:10:40.362625Z#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), 1788127839), content: TargetedMessageResponse(Services(LogUserIn(AccountId(Snowflake(882024551566159872))))) } } 1788127840.363 sable_ircd #x1B[2m2026-08-30T22:10:40.362744Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024548189343746))]) } }#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(882024548189343746))] 1788127840.363 sable_ircd #x1B[2m2026-08-30T22:10:40.362780Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024548189343746))]) } }#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(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }] 1788127840.363 sable_ircd #x1B[2m2026-08-30T22:10:40.362932Z#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 foo :You have successfully registered 1788127840.363 sable_ircd #x1B[2m2026-08-30T22:10:40.362985Z#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 1788127840.363 sable_ircd #x1B[2m2026-08-30T22:10:40.363019Z#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(882024550936612866))), UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024551566159872))) })) 1788127840.363 sable_ircd #x1B[2m2026-08-30T22:10:40.363125Z#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(882024551758696454)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024551566159872))) }) }; event clock=EventClock(1 => 882024550949195781, 99 => 882024548344934402) my clock=EventClock(1 => 882024550949195781, 99 => 882024548344934402) 1788127840.363 sable_ircd #x1B[2m2026-08-30T22:10:40.363375Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024551758696454)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024551566159872))) }) }) } #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:57377 (127.0.0.1:57377) 1788127840.365 sable_ircd #x1B[2m2026-08-30T22:10:40.364629Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024551582937091)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: Account(AccountId(Snowflake(882024551566159872))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024551566159872)), name: Nickname("foo"), 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(882024551582937091)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: Account(AccountId(Snowflake(882024551566159872))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024551566159872)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 882024550949195781, 99 => 882024548344934402) my clock=EventClock(1 => 882024551758696454, 99 => 882024548344934402) 1788127840.365 sable_ircd #x1B[2m2026-08-30T22:10:40.365071Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024551582937091)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: Account(AccountId(Snowflake(882024551566159872))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024551566159872)), name: Nickname("foo"), 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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024551582937091)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: Account(AccountId(Snowflake(882024551566159872))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024551566159872)), name: Nickname("foo"), 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:57377 (127.0.0.1:57377) 1788127840.368 sable_ircd #x1B[2m2026-08-30T22:10:40.368127Z#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(882024551758696454)), timestamp: 1788127840, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 3), old_account: None, new_account: Some(AccountId(Snowflake(882024551566159872))) }), users_to_notify: [] }) 1788127840.368 sable_ircd #x1B[2m2026-08-30T22:10:40.368165Z#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(882024551758696454)), timestamp: 1788127840, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 3), old_account: None, new_account: Some(AccountId(Snowflake(882024551566159872))) }), users_to_notify: [] } 1788127840.368 sable_ircd #x1B[2m2026-08-30T22:10:40.368200Z#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(882024551758696454)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127840.368 sable_ircd #x1B[2m2026-08-30T22:10:40.368219Z#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(882024551758696454)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] } 1788127840.368 sable_ircd #x1B[2m2026-08-30T22:10:40.368258Z#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(882024551582937091)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127840.368 sable_ircd #x1B[2m2026-08-30T22:10:40.368281Z#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(882024551582937091)), timestamp: 1788127840, change: EventComplete(EventComplete), users_to_notify: [] } 1788127840.404 sable_services #x1B[2m2026-08-30T22:10:40.403733Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }]) } }#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(882024548189343746)), timestamp: 1788127839, clock: EventClock(1 => 882024547702804481), target: User(UserId(Snowflake(882024548189343744))), 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(882024548189343745)), NewUserConnection { user: UserId(Snowflake(882024548189343744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127839 })) }) }] 1788127840.406 sable_services #x1B[2m2026-08-30T22:10:40.405546Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024551758696454)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024551566159872))) }) }) } }#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(882024551758696454)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024551566159872))) }) }; event clock=EventClock(1 => 882024550949195781, 99 => 882024548344934402) my clock=EventClock(1 => 882024550949195781, 99 => 882024551582937091) 1788127840.406 sable_services #x1B[2m2026-08-30T22:10:40.405781Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024551758696454)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024551566159872))) }) }) } }#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024551758696454)), timestamp: 1788127840, clock: EventClock(1 => 882024550949195781, 99 => 882024548344934402), target: User(UserId(Snowflake(882024550936612866))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024551566159872))) }) }) } #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:35529 (127.0.0.1:35529) 1788127840.475 1 -> S: PING synchronize486.596917877 1788127840.475 S -> 1: REGISTER SUCCESS foo :You have successfully registered 1788127840.476 sable_ircd #x1B[2m2026-08-30T22:10:40.475804Z#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 1788127840.476 sable_ircd #x1B[2m2026-08-30T22:10:40.475849Z#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 synchronize486.596917877" 1788127841.231 sable_ircd #x1B[2m2026-08-30T22:10:41.230525Z#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 :synchronize486.596917877 1788127841.231 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize486.596917877 1788127841.231 1 -> S: QUIT 1788127841.231 sable_ircd #x1B[2m2026-08-30T22:10:41.231111Z#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 1788127841.231 sable_ircd #x1B[2m2026-08-30T22:10:41.231144Z#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" 1788127841.331 1 -> S: PING synchronize487.452656399 1788127841.332 sable_ircd #x1B[2m2026-08-30T22:10:41.331483Z#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 1788127841.332 sable_ircd #x1B[2m2026-08-30T22:10:41.331531Z#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 synchronize487.452656399" 1788127842.085 sable_ircd #x1B[2m2026-08-30T22:10:42.085265Z#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 1788127842.085 sable_ircd #x1B[2m2026-08-30T22:10:42.085402Z#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)) 1788127842.085 sable_ircd #x1B[2m2026-08-30T22:10:42.085426Z#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) 1788127842.086 S -> 1: ERROR :Client quit 1788127842.086 sable_ircd #x1B[2m2026-08-30T22:10:42.085554Z#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(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 882024551758696454, 99 => 882024551582937091) my clock=EventClock(1 => 882024551758696454, 99 => 882024551582937091) 1788127842.086 sable_ircd #x1B[2m2026-08-30T22:10:42.085822Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), 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:57377 (127.0.0.1:57377) 1788127842.086 sable_ircd #x1B[2m2026-08-30T22:10:42.085838Z#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 1788127842.086 sable_ircd #x1B[2m2026-08-30T22:10:42.085893Z#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 1788127842.087 sable_ircd #x1B[2m2026-08-30T22:10:42.087334Z#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(882024558989676552)), timestamp: 1788127842, clock: EventClock(1 => 882024558981287943, 99 => 882024551582937091), target: User(UserId(Snowflake(882024550936612866))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 882024558981287943, 99 => 882024551582937091) my clock=EventClock(1 => 882024558981287943, 99 => 882024551582937091) 1788127842.088 sable_ircd #x1B[2m2026-08-30T22:10:42.087845Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558989676552)), timestamp: 1788127842, clock: EventClock(1 => 882024558981287943, 99 => 882024551582937091), target: User(UserId(Snowflake(882024550936612866))), 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:57377 (127.0.0.1:57377) 1788127842.091 sable_ircd #x1B[2m2026-08-30T22:10:42.090805Z#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(882024558981287943)), timestamp: 1788127842, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(882024550936612867)), user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 } }), users_to_notify: [] }) 1788127842.091 sable_ircd #x1B[2m2026-08-30T22:10:42.090845Z#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(882024558981287943)), timestamp: 1788127842, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(882024550936612867)), user: UserId(Snowflake(882024550936612866)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127840 } }), users_to_notify: [] } 1788127842.091 sable_ircd #x1B[2m2026-08-30T22:10:42.090894Z#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(882024558981287943)), timestamp: 1788127842, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127842.091 sable_ircd #x1B[2m2026-08-30T22:10:42.090918Z#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(882024558981287943)), timestamp: 1788127842, change: EventComplete(EventComplete), users_to_notify: [] } 1788127842.091 sable_ircd #x1B[2m2026-08-30T22:10:42.090947Z#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(882024558989676552)), timestamp: 1788127842, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 3), nickname: Nickname("foo"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1788127842.091 sable_ircd #x1B[2m2026-08-30T22:10:42.090971Z#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(882024558989676552)), timestamp: 1788127842, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(882024550936612866)), 3), nickname: Nickname("foo"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1788127842.091 sable_ircd #x1B[2m2026-08-30T22:10:42.091001Z#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(882024558989676552)), timestamp: 1788127842, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127842.091 sable_ircd #x1B[2m2026-08-30T22:10:42.091020Z#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(882024558989676552)), timestamp: 1788127842, change: EventComplete(EventComplete), users_to_notify: [] } 1788127842.091 sable_services #x1B[2m2026-08-30T22:10:42.091401Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558989676552)), timestamp: 1788127842, clock: EventClock(1 => 882024558981287943, 99 => 882024551582937091), target: User(UserId(Snowflake(882024550936612866))), 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(882024558989676552)), timestamp: 1788127842, clock: EventClock(1 => 882024558981287943, 99 => 882024551582937091), target: User(UserId(Snowflake(882024550936612866))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 882024558981287943, 99 => 882024551582937091) my clock=EventClock(1 => 882024551758696454, 99 => 882024551582937091) 1788127842.091 sable_services #x1B[2m2026-08-30T22:10:42.091450Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558989676552)), timestamp: 1788127842, clock: EventClock(1 => 882024558981287943, 99 => 882024551582937091), target: User(UserId(Snowflake(882024550936612866))), 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(882024558981287943))] 1788127842.092 sable_services #x1B[2m2026-08-30T22:10:42.091714Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558989676552)), timestamp: 1788127842, clock: EventClock(1 => 882024558981287943, 99 => 882024551582937091), target: User(UserId(Snowflake(882024550936612866))), 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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558989676552)), timestamp: 1788127842, clock: EventClock(1 => 882024558981287943, 99 => 882024551582937091), target: User(UserId(Snowflake(882024550936612866))), 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:35529 (127.0.0.1:35529) 1788127842.129 sable_services #x1B[2m2026-08-30T22:10:42.128689Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), 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(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 882024551758696454, 99 => 882024551582937091) my clock=EventClock(1 => 882024551758696454, 99 => 882024551582937091) 1788127842.129 sable_services #x1B[2m2026-08-30T22:10:42.128747Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), 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(882024558989676552)), timestamp: 1788127842, clock: EventClock(1 => 882024558981287943, 99 => 882024551582937091), target: User(UserId(Snowflake(882024550936612866))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1788127842.129 sable_services #x1B[2m2026-08-30T22:10:42.128982Z#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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), 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), 1788127839), content: NewEvent(Event { id: EventId(Snowflake(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), 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:35529 (127.0.0.1:35529) 1788127842.133 sable_ircd #x1B[2m2026-08-30T22:10:42.132544Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024558981287943))]) } }#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(882024558981287943))] 1788127842.133 sable_ircd #x1B[2m2026-08-30T22:10:42.132583Z#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), 1788127839), content: GetEvent([EventId(Snowflake(882024558981287943))]) } }#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(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), details: UserDisconnect(UserDisconnect) }] 1788127842.174 sable_services #x1B[2m2026-08-30T22:10:42.173600Z#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), 1788127839), content: BulkEvents([Event { id: EventId(Snowflake(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), 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(882024558981287943)), timestamp: 1788127842, clock: EventClock(1 => 882024551758696454, 99 => 882024551582937091), target: UserConnection(UserConnectionId(Snowflake(882024550936612867))), details: UserDisconnect(UserDisconnect) }] 1788127842.186 1 -> S: PING synchronize488.307520559 1788127842.186 1: connects to server. 1788127842.186 1 -> S: CAP LS 302 1788127842.187 sable_ircd #x1B[2m2026-08-30T22:10:42.186653Z#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 } 1788127842.187 sable_ircd #x1B[2m2026-08-30T22:10:42.186752Z#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 1788127842.187 sable_ircd #x1B[2m2026-08-30T22:10:42.186787Z#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 1788127842.187 sable_ircd #x1B[2m2026-08-30T22:10:42.186850Z#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 1788127842.187 sable_ircd #x1B[2m2026-08-30T22:10:42.186952Z#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 1788127842.187 sable_ircd #x1B[2m2026-08-30T22:10:42.186981Z#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" 1788127842.187 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127842.187 sable_ircd #x1B[2m2026-08-30T22:10:42.187075Z#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 1788127842.187 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 1788127842.187 1 -> S: CAP REQ :sasl 1788127842.188 sable_ircd #x1B[2m2026-08-30T22:10:42.187646Z#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 1788127842.188 sable_ircd #x1B[2m2026-08-30T22:10:42.187671Z#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")) 1788127842.188 sable_ircd #x1B[2m2026-08-30T22:10:42.187690Z#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 1788127842.188 sable_ircd #x1B[2m2026-08-30T22:10:42.187707Z#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: 488, tv_nsec: 308446667 }, 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 1788127842.188 sable_ircd #x1B[2m2026-08-30T22:10:42.187829Z#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 1788127842.188 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127842.188 sable_ircd #x1B[2m2026-08-30T22:10:42.187865Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP REQ :sasl" 1788127842.188 sable_ircd #x1B[2m2026-08-30T22:10:42.187975Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server CAP * ACK :sasl 1788127842.188 sable_ircd #x1B[2m2026-08-30T22:10:42.187999Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mUpdateConnectionCaps(ConnectionId(ListenerId(0), 4), ClientCapabilitySet(8)) 1788127842.228 S -> 1: :My.Little.Server CAP * ACK :sasl 1788127842.229 1 -> S: AUTHENTICATE PLAIN 1788127842.229 sable_ircd #x1B[2m2026-08-30T22:10:42.228857Z#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 1788127842.229 sable_ircd #x1B[2m2026-08-30T22:10:42.228896Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"AUTHENTICATE PLAIN" 1788127842.229 sable_ircd #x1B[2m2026-08-30T22:10:42.229024Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::command::handlers::services::sasl#x1B[0m#x1B[2m:#x1B[0m Beginning new SASL session #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(882024559585267716)) 1788127842.229 sable_ircd #x1B[2m2026-08-30T22:10:42.229116Z#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:57377", fingerprint: "04871fb970265dddc9e6bf9468d18c8c7bf96fca" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(882024559585267716)), "PLAIN")) } 1788127842.229 sable_ircd #x1B[2m2026-08-30T22:10:42.229290Z#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), 1788127839), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(882024559585267716)), "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:57377 (127.0.0.1:57377) 1788127842.231 sable_ircd #x1B[2m2026-08-30T22:10:42.230725Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(35) }) 1788127842.272 sable_services #x1B[2m2026-08-30T22:10:42.271784Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(BeginAuthenticate(SaslSessionId(Snowflake(882024559585267716)), "PLAIN")) 1788127842.272 sable_services #x1B[2m2026-08-30T22:10:42.271835Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got begin authenticate #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(882024559585267716)) #x1B[3mmechanism#x1B[0m#x1B[2m=#x1B[0m"PLAIN" 1788127842.313 sable_ircd #x1B[2m2026-08-30T22:10:42.312628Z#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), 1788127839), content: TargetedMessageResponse(Services(Authenticate(InProgress([])))) } } 1788127842.313 sable_ircd #x1B[2m2026-08-30T22:10:42.312768Z#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): AUTHENTICATE :+ 1788127842.313 sable_ircd #x1B[2m2026-08-30T22:10:42.312824Z#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 1788127842.313 S -> 1: AUTHENTICATE :+ 1788127842.313 1 -> S: AUTHENTICATE Zm9vAGZvbwBiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJi 1788127842.313 1 -> S: AUTHENTICATE YXJiYXJiYXI= 1788127842.313 sable_ircd #x1B[2m2026-08-30T22:10:42.313417Z#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 1788127842.313 sable_ircd #x1B[2m2026-08-30T22:10:42.313460Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"AUTHENTICATE Zm9vAGZvbwBiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJi" 1788127842.314 sable_ircd #x1B[2m2026-08-30T22:10:42.313558Z#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 1788127842.314 sable_ircd #x1B[2m2026-08-30T22:10:42.313590Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"AUTHENTICATE YXJiYXJiYXI=" 1788127842.314 sable_ircd #x1B[2m2026-08-30T22:10:42.313671Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::command::handlers::services::sasl#x1B[0m#x1B[2m:#x1B[0m Resuming SASL session #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(882024559585267716)) 1788127842.314 sable_ircd #x1B[2m2026-08-30T22:10:42.313788Z#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:57377", fingerprint: "04871fb970265dddc9e6bf9468d18c8c7bf96fca" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(Authenticate(SaslSessionId(Snowflake(882024559585267716)), [102, 111, 111, 0, 102, 111, 111, 0, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98])) } 1788127842.314 sable_ircd #x1B[2m2026-08-30T22:10:42.314054Z#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), 1788127839), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(Authenticate(SaslSessionId(Snowflake(882024559585267716)), [102, 111, 111, 0, 102, 111, 111, 0, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98])) }) } #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:57377 (127.0.0.1:57377) 1788127842.315 sable_ircd #x1B[2m2026-08-30T22:10:42.315405Z#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(36) }) 1788127842.357 sable_services #x1B[2m2026-08-30T22:10:42.356837Z#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(Authenticate(SaslSessionId(Snowflake(882024559585267716)), [102, 111, 111, 0, 102, 111, 111, 0, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98])) 1788127842.357 sable_services #x1B[2m2026-08-30T22:10:42.356908Z#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 authenticate data #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(882024559585267716)) #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0m[102, 111, 111, 0, 102, 111, 111, 0, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98] 1788127842.360 sable_services #x1B[2m2026-08-30T22:10:42.360254Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server::sasl::plain#x1B[0m#x1B[2m:#x1B[0m sasl login successful #x1B[3maccount_name#x1B[0m#x1B[2m=#x1B[0mNickname("foo") 1788127842.402 sable_ircd #x1B[2m2026-08-30T22:10:42.401636Z#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), 1788127839), content: TargetedMessageResponse(Services(Authenticate(Success(AccountId(Snowflake(882024551566159872)))))) } } 1788127842.402 sable_ircd #x1B[2m2026-08-30T22:10:42.401804Z#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 900 * * foo :You are now logged in as foo 1788127842.402 sable_ircd #x1B[2m2026-08-30T22:10:42.401836Z#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 903 * :SASL authentication successful 1788127842.402 sable_ircd #x1B[2m2026-08-30T22:10:42.401863Z#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 1788127842.402 S -> 1: :My.Little.Server 900 * * foo :You are now logged in as foo 1788127842.442 S -> 1: :My.Little.Server 903 * :SASL authentication successful 1788127842.444 sable_ircd #x1B[2m2026-08-30T22:10:42.444297Z#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 1788127842.445 sable_ircd #x1B[2m2026-08-30T22:10:42.444482Z#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:35529, peer: 127.0.0.1:47137, fd: 19 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x5615354c2f90, 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 1788127842.445 sable_ircd #x1B[2m2026-08-30T22:10:42.444527Z#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 1788127842.445 sable_ircd #x1B[2m2026-08-30T22:10:42.444529Z#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 1788127842.449 1: disconnects from server.