--------------------------------- Captured Out --------------------------------- ---- new test ---- 1788127933.078 sable_ircd uid=1001 1788127933.081 sable_ircd #x1B[2m2026-08-30T22:12:13.080696Z#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(882024940641980416)), timestamp: 1788127933, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127933, name: ServerName("My.Little.Server"), ts: 1788127933, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1788127933.081 sable_ircd #x1B[2m2026-08-30T22:12:13.080791Z#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 1788127933.081 sable_ircd #x1B[2m2026-08-30T22:12:13.080959Z#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(882024940641980416)), timestamp: 1788127933, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127933, name: ServerName("My.Little.Server"), ts: 1788127933, 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 1788127933.081 sable_ircd #x1B[2m2026-08-30T22:12:13.081041Z#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(882024940641980416)), timestamp: 1788127933, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1788127933.081 sable_ircd #x1B[2m2026-08-30T22:12:13.081065Z#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(882024940641980416)), timestamp: 1788127933, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1788127933.081 sable_ircd #x1B[2m2026-08-30T22:12:13.081092Z#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(882024940641980416)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127933.081 sable_ircd #x1B[2m2026-08-30T22:12:13.081105Z#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(882024940641980416)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] } 1788127933.082 sable_ircd #x1B[2m2026-08-30T22:12:13.081817Z#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 1788127933.082 sable_ircd #x1B[2m2026-08-30T22:12:13.081899Z#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(882024940646174721)), timestamp: 1788127933, clock: EventClock(1 => 882024940641980416), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127933 }) }; event clock=EventClock(1 => 882024940641980416) my clock=EventClock(1 => 882024940641980416) 1788127933.082 sable_ircd #x1B[2m2026-08-30T22:12:13.081944Z#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 1788127933.082 sable_ircd #x1B[2m2026-08-30T22:12:13.082071Z#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(882024940646174721)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127933.082 sable_ircd #x1B[2m2026-08-30T22:12:13.082094Z#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(882024940646174721)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] } 1788127933.175 sable_ircd #x1B[2m2026-08-30T22:12:13.174662Z#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 } 1788127933.175 sable_ircd #x1B[2m2026-08-30T22:12:13.174790Z#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 1788127933.175 sable_ircd #x1B[2m2026-08-30T22:12:13.174823Z#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 1788127933.175 sable_ircd #x1B[2m2026-08-30T22:12:13.174884Z#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 1788127933.175 sable_ircd #x1B[2m2026-08-30T22:12:13.175005Z#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 1788127933.175 sable_ircd #x1B[2m2026-08-30T22:12:13.175054Z#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" 1788127933.175 sable_ircd #x1B[2m2026-08-30T22:12:13.175150Z#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 1788127933.175 sable_ircd #x1B[2m2026-08-30T22:12:13.175220Z#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)) 1788127933.175 sable_ircd #x1B[2m2026-08-30T22:12:13.175243Z#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) 1788127933.176 sable_ircd #x1B[2m2026-08-30T22:12:13.175588Z#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 1788127933.176 sable_ircd #x1B[2m2026-08-30T22:12:13.175652Z#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 1788127933.176 sable_ircd #x1B[2m2026-08-30T22:12:13.175796Z#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 1788127933.195 1: connects to server. 1788127933.195 1 -> S: NICK coolNick 1788127933.195 1 -> S: USER myusernam 0 * :My UniqueReal Name 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.195674Z#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 } 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.195771Z#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 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.195803Z#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 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.195852Z#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 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.195950Z#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 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.195985Z#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 coolNick" 1788127933.196 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.196102Z#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: 579, tv_nsec: 317455682 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("coolNick")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.196151Z#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 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.196168Z#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 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.196186Z#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 myusernam 0 * :My UniqueReal Name" 1788127933.196 sable_ircd #x1B[2m2026-08-30T22:12:13.196230Z#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: 579, tv_nsec: 317455682 }, attach_user_id: OnceLock(), user: OnceLock(Username("myusernam")), extra_user_params: OnceLock(("0", "*")), nick: OnceLock(Nickname("coolNick")), realname: OnceLock(Realname("My UniqueReal Name")), 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 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.196559Z#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 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.196585Z#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")) 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.196603Z#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 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.196617Z#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: 579, tv_nsec: 317455682 }, attach_user_id: OnceLock(), user: OnceLock(Username("myusernam")), extra_user_params: OnceLock(("0", "*")), nick: OnceLock(Nickname("coolNick")), realname: OnceLock(Realname("My UniqueReal Name")), 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 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.196649Z#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)) 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.196834Z#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(882024941128519682)), timestamp: 1788127933, clock: EventClock(1 => 882024940646174721), target: User(UserId(Snowflake(882024941128519680))), details: NewUser(NewUser { nickname: Nickname("coolNick"), username: Username("myusernam"), visible_hostname: Hostname("localhost"), realname: Realname("My UniqueReal Name"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(882024941128519681)), NewUserConnection { user: UserId(Snowflake(882024941128519680)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127933 })) }) }; event clock=EventClock(1 => 882024940646174721) my clock=EventClock(1 => 882024940646174721) 1788127933.197 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.196923Z#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 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197141Z#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(882024941128519682)), timestamp: 1788127933, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024941128519680)), 1) }), users_to_notify: [] }) 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197173Z#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(882024941128519682)), timestamp: 1788127933, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024941128519680)), 1) }), users_to_notify: [] } 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197209Z#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(882024941128519682)), timestamp: 1788127933, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024941128519680)), 2), connection: UserConnectionId(Snowflake(882024941128519681)) }), users_to_notify: [] }) 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197227Z#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(882024941128519682)), timestamp: 1788127933, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024941128519680)), 2), connection: UserConnectionId(Snowflake(882024941128519681)) }), users_to_notify: [] } 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197273Z#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 coolNick :Welcome to the test Internet Relay Chat network, coolNick 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197296Z#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 coolNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197321Z#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 coolNick :This server was created 2026-08-30 22:12:13.197311798 UTC 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197339Z#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 coolNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197375Z#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 coolNick 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 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197413Z#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 coolNick :MOTD File is missing 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197434Z#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): :coolNick!myusernam@localhost MODE coolNick + 1788127933.197 sable_ircd #x1B[2m2026-08-30T22:12:13.197452Z#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 coolNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127933.198 sable_ircd #x1B[2m2026-08-30T22:12:13.197482Z#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(882024941128519682)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127933.198 sable_ircd #x1B[2m2026-08-30T22:12:13.197497Z#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(882024941128519682)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] } 1788127933.198 S -> 1: :My.Little.Server 001 coolNick :Welcome to the test Internet Relay Chat network, coolNick 1788127933.298 1 -> S: PING synchronize579.419450571 1788127933.298 S -> 1: :My.Little.Server 002 coolNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127933.298 S -> 1: :My.Little.Server 003 coolNick :This server was created 2026-08-30 22:12:13.197311798 UTC 1788127933.298 S -> 1: :My.Little.Server 004 coolNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127933.298 S -> 1: :My.Little.Server 005 coolNick 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 1788127933.298 S -> 1: :My.Little.Server 422 coolNick :MOTD File is missing 1788127933.298 S -> 1: :coolNick!myusernam@localhost MODE coolNick + 1788127933.298 S -> 1: :My.Little.Server NOTICE coolNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127933.298 sable_ircd #x1B[2m2026-08-30T22:12:13.298341Z#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 1788127933.298 sable_ircd #x1B[2m2026-08-30T22:12:13.298408Z#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 synchronize579.419450571" 1788127933.299 sable_ircd #x1B[2m2026-08-30T22:12:13.298514Z#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 :synchronize579.419450571 1788127933.299 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize579.419450571 1788127933.299 1 -> S: JOIN #chan 1788127933.299 sable_ircd #x1B[2m2026-08-30T22:12:13.298923Z#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 1788127933.299 sable_ircd #x1B[2m2026-08-30T22:12:13.298951Z#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"JOIN #chan" 1788127933.299 sable_ircd #x1B[2m2026-08-30T22:12:13.299112Z#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(882024941560532995)), timestamp: 1788127933, clock: EventClock(1 => 882024941128519682), target: Channel(ChannelId(Snowflake(882024941560532994))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 882024941128519682) my clock=EventClock(1 => 882024941128519682) 1788127933.299 sable_ircd #x1B[2m2026-08-30T22:12:13.299212Z#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 1788127933.299 sable_ircd #x1B[2m2026-08-30T22:12:13.299263Z#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(882024941560532996)), timestamp: 1788127933, clock: EventClock(1 => 882024941560532995), target: Membership(MembershipId(UserId(Snowflake(882024941128519680)), ChannelId(Snowflake(882024941560532994)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024941560532994)), user: UserId(Snowflake(882024941128519680)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 882024941560532995) my clock=EventClock(1 => 882024941560532995) 1788127933.299 sable_ircd #x1B[2m2026-08-30T22:12:13.299344Z#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 1788127933.299 sable_ircd #x1B[2m2026-08-30T22:12:13.299434Z#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 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299681Z#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(882024941560532995)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299709Z#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(882024941560532995)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] } 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299741Z#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(882024941560532996)), timestamp: 1788127933, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024941128519680)), ChannelId(Snowflake(882024941560532994))), user: HistoricUserId(UserId(Snowflake(882024941128519680)), 2) }), users_to_notify: [UserId(Snowflake(882024941128519680))] }) 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299765Z#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(882024941560532996)), timestamp: 1788127933, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024941128519680)), ChannelId(Snowflake(882024941560532994))), user: HistoricUserId(UserId(Snowflake(882024941128519680)), 2) }), users_to_notify: [UserId(Snowflake(882024941128519680))] } 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299816Z#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): :coolNick!myusernam@localhost JOIN #chan 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299848Z#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): :coolNick!myusernam@localhost MODE #chan +o coolNick 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299888Z#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 353 coolNick = #chan :@coolNick 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299906Z#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 366 coolNick #chan :End of names list 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299933Z#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(882024941560532996)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127933.300 sable_ircd #x1B[2m2026-08-30T22:12:13.299952Z#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(882024941560532996)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] } 1788127933.376 sable_ircd #x1B[2m2026-08-30T22:12:13.375594Z#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(882024941879300104)), timestamp: 1788127933, clock: EventClock(1 => 882024690225254407), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127933 }) }; event clock=EventClock(1 => 882024690225254407) my clock=EventClock(1 => 882024690225254407) 1788127933.376 sable_ircd #x1B[2m2026-08-30T22:12:13.375687Z#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 1788127933.376 sable_ircd #x1B[2m2026-08-30T22:12:13.375865Z#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(882024941879300104)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127933.376 sable_ircd #x1B[2m2026-08-30T22:12:13.375896Z#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(882024941879300104)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] } 1788127933.377 sable_ircd #x1B[2m2026-08-30T22:12:13.376900Z#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 1788127933.399 1 -> S: PING synchronize579.52051183 1788127933.399 S -> 1: :coolNick!myusernam@localhost JOIN #chan 1788127933.399 S -> 1: :coolNick!myusernam@localhost MODE #chan +o coolNick 1788127933.399 S -> 1: :My.Little.Server 353 coolNick = #chan :@coolNick 1788127933.399 S -> 1: :My.Little.Server 366 coolNick #chan :End of names list 1788127933.399 sable_ircd #x1B[2m2026-08-30T22:12:13.399417Z#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 1788127933.399 sable_ircd #x1B[2m2026-08-30T22:12:13.399463Z#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 synchronize579.52051183" 1788127934.152 sable_ircd #x1B[2m2026-08-30T22:12:14.152099Z#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 :synchronize579.52051183 1788127934.152 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize579.52051183 1788127934.153 2: connects to server. 1788127934.153 2 -> S: NICK otherNick 1788127934.153 2 -> S: USER username * * :Realname 1788127934.153 sable_ircd #x1B[2m2026-08-30T22:12:14.152868Z#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 } 1788127934.153 sable_ircd #x1B[2m2026-08-30T22:12:14.152936Z#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 1788127934.153 sable_ircd #x1B[2m2026-08-30T22:12:14.152961Z#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 1788127934.153 sable_ircd #x1B[2m2026-08-30T22:12:14.153003Z#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 1788127934.153 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127934.153 sable_ircd #x1B[2m2026-08-30T22:12:14.153086Z#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 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153115Z#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 otherNick" 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153237Z#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: 580, tv_nsec: 274610782 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("otherNick")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153282Z#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 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153304Z#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 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153321Z#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 username * * :Realname" 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153366Z#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: 580, tv_nsec: 274610782 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("otherNick")), realname: OnceLock(Realname("Realname")), 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 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153848Z#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 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153874Z#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")) 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153900Z#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 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153920Z#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: 580, tv_nsec: 274610782 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("otherNick")), realname: OnceLock(Realname("Realname")), 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 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.153962Z#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)) 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.154152Z#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(882024945146662917)), timestamp: 1788127934, clock: EventClock(1 => 882024941560532996), target: User(UserId(Snowflake(882024945146662915))), details: NewUser(NewUser { nickname: Nickname("otherNick"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(882024945146662916)), NewUserConnection { user: UserId(Snowflake(882024945146662915)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127934 })) }) }; event clock=EventClock(1 => 882024941560532996) my clock=EventClock(1 => 882024941560532996) 1788127934.154 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127934.154 sable_ircd #x1B[2m2026-08-30T22:12:14.154243Z#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 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154488Z#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(882024945146662917)), timestamp: 1788127934, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024945146662915)), 1) }), users_to_notify: [] }) 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154515Z#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(882024945146662917)), timestamp: 1788127934, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024945146662915)), 1) }), users_to_notify: [] } 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154549Z#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(882024945146662917)), timestamp: 1788127934, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024945146662915)), 2), connection: UserConnectionId(Snowflake(882024945146662916)) }), users_to_notify: [] }) 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154563Z#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(882024945146662917)), timestamp: 1788127934, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024945146662915)), 2), connection: UserConnectionId(Snowflake(882024945146662916)) }), users_to_notify: [] } 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154596Z#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 otherNick :Welcome to the test Internet Relay Chat network, otherNick 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154612Z#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 otherNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154626Z#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 otherNick :This server was created 2026-08-30 22:12:14.154619113 UTC 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154637Z#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 otherNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154649Z#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 otherNick 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 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154661Z#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 otherNick :MOTD File is missing 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154672Z#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): :otherNick!username@localhost MODE otherNick + 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154682Z#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 otherNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154697Z#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(882024945146662917)), timestamp: 1788127934, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.154708Z#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(882024945146662917)), timestamp: 1788127934, change: EventComplete(EventComplete), users_to_notify: [] } 1788127934.155 S -> 2: :My.Little.Server 001 otherNick :Welcome to the test Internet Relay Chat network, otherNick 1788127934.155 S -> 2: :My.Little.Server 002 otherNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127934.155 S -> 2: :My.Little.Server 003 otherNick :This server was created 2026-08-30 22:12:14.154619113 UTC 1788127934.155 S -> 2: :My.Little.Server 004 otherNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127934.155 S -> 2: :My.Little.Server 005 otherNick 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 1788127934.155 S -> 2: :My.Little.Server 422 otherNick :MOTD File is missing 1788127934.155 S -> 2: :otherNick!username@localhost MODE otherNick + 1788127934.155 S -> 2: :My.Little.Server NOTICE otherNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127934.155 2 -> S: PING foo 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.155264Z#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 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.155300Z#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 foo" 1788127934.155 sable_ircd #x1B[2m2026-08-30T22:12:14.155369Z#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 :foo 1788127934.956 2 -> S: PING synchronize581.077592587 1788127934.956 S -> 2: :My.Little.Server PONG My.Little.Server :foo 1788127934.957 sable_ircd #x1B[2m2026-08-30T22:12:14.956558Z#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 1788127934.957 sable_ircd #x1B[2m2026-08-30T22:12:14.956625Z#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 synchronize581.077592587" 1788127934.957 sable_ircd #x1B[2m2026-08-30T22:12:14.956755Z#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 :synchronize581.077592587 1788127934.957 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize581.077592587 1788127935.057 2 -> S: PING synchronize581.178770485 1788127935.058 sable_ircd #x1B[2m2026-08-30T22:12:15.057695Z#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 1788127935.058 sable_ircd #x1B[2m2026-08-30T22:12:15.057759Z#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 synchronize581.178770485" 1788127935.058 sable_ircd #x1B[2m2026-08-30T22:12:15.057893Z#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 :synchronize581.178770485 1788127935.058 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize581.178770485 1788127935.058 2 -> S: JOIN #chan 1788127935.058 sable_ircd #x1B[2m2026-08-30T22:12:15.058397Z#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 1788127935.058 sable_ircd #x1B[2m2026-08-30T22:12:15.058433Z#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"JOIN #chan" 1788127935.158 2 -> S: PING synchronize581.279949473 1788127935.159 sable_ircd #x1B[2m2026-08-30T22:12:15.158888Z#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 1788127935.159 sable_ircd #x1B[2m2026-08-30T22:12:15.158957Z#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 synchronize581.279949473" 1788127936.159 2: waiting… 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165435Z#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(882024953581408262)), timestamp: 1788127936, clock: EventClock(1 => 882024945146662917), target: Membership(MembershipId(UserId(Snowflake(882024945146662915)), ChannelId(Snowflake(882024941560532994)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024941560532994)), user: UserId(Snowflake(882024945146662915)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882024945146662917) my clock=EventClock(1 => 882024945146662917) 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165576Z#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 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165602Z#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 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165792Z#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(882024953581408262)), timestamp: 1788127936, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024945146662915)), ChannelId(Snowflake(882024941560532994))), user: HistoricUserId(UserId(Snowflake(882024945146662915)), 2) }), users_to_notify: [UserId(Snowflake(882024941128519680)), UserId(Snowflake(882024945146662915))] }) 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165822Z#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(882024953581408262)), timestamp: 1788127936, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024945146662915)), ChannelId(Snowflake(882024941560532994))), user: HistoricUserId(UserId(Snowflake(882024945146662915)), 2) }), users_to_notify: [UserId(Snowflake(882024941128519680)), UserId(Snowflake(882024945146662915))] } 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165870Z#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): :otherNick!username@localhost JOIN #chan 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165895Z#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): :otherNick!username@localhost JOIN #chan 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165922Z#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 353 otherNick = #chan :@coolNick otherNick 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165934Z#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 366 otherNick #chan :End of names list 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165957Z#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(882024953581408262)), timestamp: 1788127936, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127936.166 sable_ircd #x1B[2m2026-08-30T22:12:16.165969Z#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(882024953581408262)), timestamp: 1788127936, change: EventComplete(EventComplete), users_to_notify: [] } 1788127936.166 S -> 2: :otherNick!username@localhost JOIN #chan 1788127936.207 S -> 2: :My.Little.Server 353 otherNick = #chan :@coolNick otherNick 1788127936.207 S -> 2: :My.Little.Server 366 otherNick #chan :End of names list 1788127937.172 sable_ircd #x1B[2m2026-08-30T22:12:17.172297Z#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 :synchronize581.279949473 1788127937.173 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize581.279949473 1788127937.173 1 -> S: AWAY :be right back 1788127937.173 sable_ircd #x1B[2m2026-08-30T22:12:17.172967Z#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 1788127937.173 sable_ircd #x1B[2m2026-08-30T22:12:17.173004Z#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"AWAY :be right back" 1788127937.173 sable_ircd #x1B[2m2026-08-30T22:12:17.173194Z#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(882024957809266695)), timestamp: 1788127937, clock: EventClock(1 => 882024953581408262), target: User(UserId(Snowflake(882024941128519680))), details: UserAway(UserAway { reason: Some(AwayReason("be right back")) }) }; event clock=EventClock(1 => 882024953581408262) my clock=EventClock(1 => 882024953581408262) 1788127937.173 sable_ircd #x1B[2m2026-08-30T22:12:17.173303Z#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 1788127937.173 sable_ircd #x1B[2m2026-08-30T22:12:17.173313Z#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 1788127937.174 sable_ircd #x1B[2m2026-08-30T22:12:17.173514Z#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(882024957809266695)), timestamp: 1788127937, change: UserAwayChange(UserAwayChange { user: HistoricUserId(UserId(Snowflake(882024941128519680)), 3), old_reason: None, new_reason: Some(AwayReason("be right back")) }), users_to_notify: [UserId(Snowflake(882024945146662915)), UserId(Snowflake(882024941128519680))] }) 1788127937.174 sable_ircd #x1B[2m2026-08-30T22:12:17.173543Z#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(882024957809266695)), timestamp: 1788127937, change: UserAwayChange(UserAwayChange { user: HistoricUserId(UserId(Snowflake(882024941128519680)), 3), old_reason: None, new_reason: Some(AwayReason("be right back")) }), users_to_notify: [UserId(Snowflake(882024945146662915)), UserId(Snowflake(882024941128519680))] } 1788127937.174 sable_ircd #x1B[2m2026-08-30T22:12:17.173592Z#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 306 coolNick :You have been marked as being away 1788127937.174 sable_ircd #x1B[2m2026-08-30T22:12:17.173623Z#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(882024957809266695)), timestamp: 1788127937, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127937.174 sable_ircd #x1B[2m2026-08-30T22:12:17.173635Z#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(882024957809266695)), timestamp: 1788127937, change: EventComplete(EventComplete), users_to_notify: [] } 1788127937.273 1 -> S: PING synchronize583.394499833 1788127937.273 S -> 1: :otherNick!username@localhost JOIN #chan 1788127937.273 S -> 1: :My.Little.Server 306 coolNick :You have been marked as being away 1788127937.274 sable_ircd #x1B[2m2026-08-30T22:12:17.273444Z#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 1788127937.274 sable_ircd #x1B[2m2026-08-30T22:12:17.273508Z#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 synchronize583.394499833" 1788127937.274 sable_ircd #x1B[2m2026-08-30T22:12:17.273634Z#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 :synchronize583.394499833 1788127937.274 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize583.394499833 1788127937.374 2 -> S: PING synchronize583.495622587 1788127937.375 sable_ircd #x1B[2m2026-08-30T22:12:17.374571Z#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 1788127937.375 sable_ircd #x1B[2m2026-08-30T22:12:17.374640Z#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 synchronize583.495622587" 1788127938.129 sable_ircd #x1B[2m2026-08-30T22:12:18.128441Z#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 :synchronize583.495622587 1788127938.129 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize583.495622587 1788127938.129 2 -> S: WHO coolnick 1788127938.129 sable_ircd #x1B[2m2026-08-30T22:12:18.129050Z#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 1788127938.129 sable_ircd #x1B[2m2026-08-30T22:12:18.129092Z#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"WHO coolnick" 1788127938.229 2 -> S: PING synchronize584.350602928 1788127938.229 sable_ircd #x1B[2m2026-08-30T22:12:18.229423Z#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 1788127938.230 sable_ircd #x1B[2m2026-08-30T22:12:18.229478Z#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 synchronize584.350602928" 1788127939.230 2: waiting… 1788127939.235 sable_ircd #x1B[2m2026-08-30T22:12:19.234680Z#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 352 otherNick * myusernam localhost * coolNick G :0 My UniqueReal Name 1788127939.235 sable_ircd #x1B[2m2026-08-30T22:12:19.234730Z#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 315 otherNick coolnick :End of /WHO list 1788127939.235 S -> 2: :My.Little.Server 352 otherNick * myusernam localhost * coolNick G :0 My UniqueReal Name 1788127939.275 S -> 2: :My.Little.Server 315 otherNick coolnick :End of /WHO list 1788127940.239 sable_ircd #x1B[2m2026-08-30T22:12:20.239132Z#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 :synchronize584.350602928 1788127940.240 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize584.350602928 1788127940.242 1: disconnects from server. 1788127940.242 2: disconnects from server.