--------------------------------- Captured Out --------------------------------- ---- new test ---- 1779570727.222 sable_ircd uid=1001 1779570727.226 sable_ircd #x1B[2m2026-05-23T21:12:07.225239Z#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(846133417895530496)), timestamp: 1779570727, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1779570727, name: ServerName("My.Little.Server"), ts: 1779570727, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1779570727.226 sable_ircd #x1B[2m2026-05-23T21:12:07.225362Z#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 1779570727.226 sable_ircd #x1B[2m2026-05-23T21:12:07.225511Z#x1B[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 1779570727.226 sable_ircd #x1B[2m2026-05-23T21:12:07.226047Z#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(846133417895530496)), timestamp: 1779570727, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1779570727, name: ServerName("My.Little.Server"), ts: 1779570727, 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 1779570727.226 sable_ircd #x1B[2m2026-05-23T21:12:07.226242Z#x1B[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(846133417895530496)), timestamp: 1779570727, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1779570727.226 sable_ircd #x1B[2m2026-05-23T21:12:07.226287Z#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(846133417899724801)), timestamp: 1779570727, clock: EventClock(1 => 846133417895530496), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1779570727 }) }; event clock=EventClock(1 => 846133417895530496) my clock=EventClock(1 => 846133417895530496) 1779570727.226 sable_ircd #x1B[2m2026-05-23T21:12:07.226317Z#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(846133417895530496)), timestamp: 1779570727, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1779570727.226 sable_ircd #x1B[2m2026-05-23T21:12:07.226366Z#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 1779570727.227 sable_ircd #x1B[2m2026-05-23T21:12:07.226463Z#x1B[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(846133417895530496)), timestamp: 1779570727, change: EventComplete(EventComplete), users_to_notify: [] }) 1779570727.227 sable_ircd #x1B[2m2026-05-23T21:12:07.226506Z#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(846133417895530496)), timestamp: 1779570727, change: EventComplete(EventComplete), users_to_notify: [] } 1779570727.227 sable_ircd #x1B[2m2026-05-23T21:12:07.226669Z#x1B[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(846133417899724801)), timestamp: 1779570727, change: EventComplete(EventComplete), users_to_notify: [] }) 1779570727.227 sable_ircd #x1B[2m2026-05-23T21:12:07.226739Z#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(846133417899724801)), timestamp: 1779570727, change: EventComplete(EventComplete), users_to_notify: [] } 1779570727.318 sable_ircd #x1B[2m2026-05-23T21:12:07.317554Z#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 } 1779570727.318 sable_ircd #x1B[2m2026-05-23T21:12:07.317717Z#x1B[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 1779570727.318 sable_ircd #x1B[2m2026-05-23T21:12:07.317777Z#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 1779570727.318 sable_ircd #x1B[2m2026-05-23T21:12:07.317895Z#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 1779570727.318 sable_ircd #x1B[2m2026-05-23T21:12:07.318090Z#x1B[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 1779570727.318 sable_ircd #x1B[2m2026-05-23T21:12:07.318152Z#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" 1779570727.318 sable_ircd #x1B[2m2026-05-23T21:12:07.318276Z#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 1779570727.318 sable_ircd #x1B[2m2026-05-23T21:12:07.318386Z#x1B[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)) 1779570727.318 sable_ircd #x1B[2m2026-05-23T21:12:07.318427Z#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) 1779570727.319 sable_ircd #x1B[2m2026-05-23T21:12:07.318941Z#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 1779570727.319 sable_ircd #x1B[2m2026-05-23T21:12:07.319043Z#x1B[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 1779570727.319 sable_ircd #x1B[2m2026-05-23T21:12:07.319213Z#x1B[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 1779570727.339 1: connects to server. 1779570727.339 1 -> S: NICK nick1 1779570727.339 1 -> S: USER username * * :Realname 1779570727.339 sable_ircd #x1B[2m2026-05-23T21:12:07.339254Z#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 } 1779570727.339 sable_ircd #x1B[2m2026-05-23T21:12:07.339423Z#x1B[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 1779570727.339 sable_ircd #x1B[2m2026-05-23T21:12:07.339469Z#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 1779570727.340 sable_ircd #x1B[2m2026-05-23T21:12:07.339543Z#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 1779570727.340 sable_ircd #x1B[2m2026-05-23T21:12:07.339718Z#x1B[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 1779570727.340 sable_ircd #x1B[2m2026-05-23T21:12:07.339769Z#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 nick1" 1779570727.340 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1779570727.340 sable_ircd #x1B[2m2026-05-23T21:12:07.339988Z#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: 602, tv_nsec: 667725882 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("nick1")), 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 1779570727.340 sable_ircd #x1B[2m2026-05-23T21:12:07.340069Z#x1B[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 1779570727.340 sable_ircd #x1B[2m2026-05-23T21:12:07.340105Z#x1B[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 1779570727.340 sable_ircd #x1B[2m2026-05-23T21:12:07.340136Z#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 username * * :Realname" 1779570727.340 sable_ircd #x1B[2m2026-05-23T21:12:07.340200Z#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: 602, tv_nsec: 667725882 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick1")), 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 1779570727.341 sable_ircd #x1B[2m2026-05-23T21:12:07.340746Z#x1B[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 1779570727.341 sable_ircd #x1B[2m2026-05-23T21:12:07.340814Z#x1B[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")) 1779570727.341 sable_ircd #x1B[2m2026-05-23T21:12:07.340854Z#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 1779570727.341 sable_ircd #x1B[2m2026-05-23T21:12:07.340874Z#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: 602, tv_nsec: 667725882 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick1")), 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 1779570727.341 sable_ircd #x1B[2m2026-05-23T21:12:07.340916Z#x1B[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)) 1779570727.341 sable_ircd #x1B[2m2026-05-23T21:12:07.341130Z#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(846133418382069762)), timestamp: 1779570727, clock: EventClock(1 => 846133417899724801), target: User(UserId(Snowflake(846133418382069760))), details: NewUser(NewUser { nickname: Nickname("nick1"), 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(846133418382069761)), NewUserConnection { user: UserId(Snowflake(846133418382069760)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1779570727 })) }) }; event clock=EventClock(1 => 846133417899724801) my clock=EventClock(1 => 846133417899724801) 1779570727.341 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1779570727.341 sable_ircd #x1B[2m2026-05-23T21:12:07.341242Z#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 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.341532Z#x1B[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(846133418382069762)), timestamp: 1779570727, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(846133418382069760)), 1) }), users_to_notify: [] }) 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.341569Z#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(846133418382069762)), timestamp: 1779570727, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(846133418382069760)), 1) }), users_to_notify: [] } 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.341642Z#x1B[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(846133418382069762)), timestamp: 1779570727, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(846133418382069760)), 2), connection: UserConnectionId(Snowflake(846133418382069761)) }), users_to_notify: [] }) 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.341677Z#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(846133418382069762)), timestamp: 1779570727, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(846133418382069760)), 2), connection: UserConnectionId(Snowflake(846133418382069761)) }), users_to_notify: [] } 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.341746Z#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 nick1 :Welcome to the test Internet Relay Chat network, nick1 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.341818Z#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 nick1 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.341864Z#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 nick1 :This server was created 2026-05-23 21:12:07.341849292 UTC 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.341906Z#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 nick1 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.341969Z#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 nick1 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 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.342007Z#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 nick1 :MOTD File is missing 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.342050Z#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): :nick1!username@localhost MODE nick1 + 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.342085Z#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 nick1 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.342143Z#x1B[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(846133418382069762)), timestamp: 1779570727, change: EventComplete(EventComplete), users_to_notify: [] }) 1779570727.342 sable_ircd #x1B[2m2026-05-23T21:12:07.342174Z#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(846133418382069762)), timestamp: 1779570727, change: EventComplete(EventComplete), users_to_notify: [] } 1779570727.342 S -> 1: :My.Little.Server 001 nick1 :Welcome to the test Internet Relay Chat network, nick1 1779570727.342 1 -> S: PING foo 1779570727.343 sable_ircd #x1B[2m2026-05-23T21:12:07.342736Z#x1B[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 1779570727.343 sable_ircd #x1B[2m2026-05-23T21:12:07.342776Z#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 foo" 1779570727.343 sable_ircd #x1B[2m2026-05-23T21:12:07.342879Z#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 :foo 1779570727.443 1 -> S: PING synchronize602.770827173 1779570727.443 S -> 1: :My.Little.Server 002 nick1 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1779570727.443 S -> 1: :My.Little.Server 003 nick1 :This server was created 2026-05-23 21:12:07.341849292 UTC 1779570727.443 S -> 1: :My.Little.Server 004 nick1 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1779570727.443 S -> 1: :My.Little.Server 005 nick1 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 1779570727.443 S -> 1: :My.Little.Server 422 nick1 :MOTD File is missing 1779570727.443 S -> 1: :nick1!username@localhost MODE nick1 + 1779570727.443 S -> 1: :My.Little.Server NOTICE nick1 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1779570727.443 S -> 1: :My.Little.Server PONG My.Little.Server :foo 1779570727.443 sable_ircd #x1B[2m2026-05-23T21:12:07.443299Z#x1B[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 1779570727.443 sable_ircd #x1B[2m2026-05-23T21:12:07.443372Z#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 synchronize602.770827173" 1779570727.444 sable_ircd #x1B[2m2026-05-23T21:12:07.443522Z#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 :synchronize602.770827173 1779570727.444 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize602.770827173 1779570727.551 sable_history #x1B[2m2027-05-23T22:29:38.619052Z#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(978424498195996758)), timestamp: 1811111378, clock: EventClock(1 => 978403597525979137, 50 => 978424246546145365), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811111378 }) }; event clock=EventClock(1 => 978403597525979137, 50 => 978424246546145365) my clock=EventClock(1 => 978403597525979137, 50 => 978424246546145365) 1779570727.551 sable_history #x1B[2m2027-05-23T22:29:38.620695Z#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 1779570727.864 sable_history #x1B[2m2027-05-23T22:35:14.960360Z#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(978425908912398429)), timestamp: 1811111714, clock: EventClock(1 => 978404001450037270, 50 => 978425657249964124, 99 => 978404005409861636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811111714 }) }; event clock=EventClock(1 => 978404001450037270, 50 => 978425657249964124, 99 => 978404005409861636) my clock=EventClock(1 => 978404001450037270, 50 => 978425657249964124, 99 => 978404005409861636) 1779570727.864 sable_history #x1B[2m2027-05-23T22:35:14.961953Z#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 1779570727.994 sable_history #x1B[2m2027-05-23T22:29:38.957494Z#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(978424499613671510)), timestamp: 1811111378, clock: EventClock(1 => 978403599421804545, 50 => 978424247955431509), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811111378 }) }; event clock=EventClock(1 => 978403599421804545, 50 => 978424247955431509) my clock=EventClock(1 => 978403599421804545, 50 => 978424247955431509) 1779570727.994 sable_history #x1B[2m2027-05-23T22:29:38.959496Z#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 1779570728.145 2: connects to server. 1779570728.145 2 -> S: NICK nick2 1779570728.145 2 -> S: USER username * * :Realname 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.145535Z#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 } 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.145699Z#x1B[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 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.145748Z#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 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.145858Z#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 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.146031Z#x1B[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 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.146081Z#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 nick2" 1779570728.146 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.146227Z#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: 603, tv_nsec: 473999103 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("nick2")), 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 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.146292Z#x1B[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 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.146340Z#x1B[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 1779570728.146 sable_ircd #x1B[2m2026-05-23T21:12:08.146384Z#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" 1779570728.147 sable_ircd #x1B[2m2026-05-23T21:12:08.146484Z#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: 603, tv_nsec: 473999103 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick2")), 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 1779570728.147 sable_ircd #x1B[2m2026-05-23T21:12:08.147070Z#x1B[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 1779570728.147 sable_ircd #x1B[2m2026-05-23T21:12:08.147105Z#x1B[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")) 1779570728.147 sable_ircd #x1B[2m2026-05-23T21:12:08.147142Z#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 1779570728.147 sable_ircd #x1B[2m2026-05-23T21:12:08.147175Z#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: 603, tv_nsec: 473999103 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick2")), 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 1779570728.147 sable_ircd #x1B[2m2026-05-23T21:12:08.147238Z#x1B[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)) 1779570728.148 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.147486Z#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(846133421762678787)), timestamp: 1779570728, clock: EventClock(1 => 846133418382069762), target: User(UserId(Snowflake(846133421762678786))), details: NewUser(NewUser { nickname: Nickname("nick2"), 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(846133421762678787)), NewUserConnection { user: UserId(Snowflake(846133421762678786)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1779570728 })) }) }; event clock=EventClock(1 => 846133418382069762) my clock=EventClock(1 => 846133418382069762) 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.147586Z#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 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.147904Z#x1B[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(846133421762678787)), timestamp: 1779570728, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(846133421762678786)), 1) }), users_to_notify: [] }) 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.147943Z#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(846133421762678787)), timestamp: 1779570728, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(846133421762678786)), 1) }), users_to_notify: [] } 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148016Z#x1B[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(846133421762678787)), timestamp: 1779570728, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(846133421762678786)), 2), connection: UserConnectionId(Snowflake(846133421762678787)) }), users_to_notify: [] }) 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148052Z#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(846133421762678787)), timestamp: 1779570728, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(846133421762678786)), 2), connection: UserConnectionId(Snowflake(846133421762678787)) }), users_to_notify: [] } 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148117Z#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 nick2 :Welcome to the test Internet Relay Chat network, nick2 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148161Z#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 nick2 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148202Z#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 nick2 :This server was created 2026-05-23 21:12:08.148186896 UTC 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148247Z#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 nick2 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148290Z#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 nick2 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 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148332Z#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 nick2 :MOTD File is missing 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148372Z#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): :nick2!username@localhost MODE nick2 + 1779570728.148 sable_ircd #x1B[2m2026-05-23T21:12:08.148411Z#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 nick2 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1779570728.149 sable_ircd #x1B[2m2026-05-23T21:12:08.148464Z#x1B[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(846133421762678787)), timestamp: 1779570728, change: EventComplete(EventComplete), users_to_notify: [] }) 1779570728.149 sable_ircd #x1B[2m2026-05-23T21:12:08.148503Z#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(846133421762678787)), timestamp: 1779570728, change: EventComplete(EventComplete), users_to_notify: [] } 1779570728.149 S -> 2: :My.Little.Server 001 nick2 :Welcome to the test Internet Relay Chat network, nick2 1779570728.149 2 -> S: PING foo 1779570728.149 sable_ircd #x1B[2m2026-05-23T21:12:08.149112Z#x1B[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 1779570728.149 sable_ircd #x1B[2m2026-05-23T21:12:08.149150Z#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" 1779570728.149 sable_ircd #x1B[2m2026-05-23T21:12:08.149216Z#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 1779570728.249 2 -> S: PING synchronize603.577278759 1779570728.249 S -> 2: :My.Little.Server 002 nick2 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1779570728.249 S -> 2: :My.Little.Server 003 nick2 :This server was created 2026-05-23 21:12:08.148186896 UTC 1779570728.249 S -> 2: :My.Little.Server 004 nick2 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1779570728.249 S -> 2: :My.Little.Server 005 nick2 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 1779570728.249 S -> 2: :My.Little.Server 422 nick2 :MOTD File is missing 1779570728.249 S -> 2: :nick2!username@localhost MODE nick2 + 1779570728.249 S -> 2: :My.Little.Server NOTICE nick2 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1779570728.249 S -> 2: :My.Little.Server PONG My.Little.Server :foo 1779570728.250 sable_ircd #x1B[2m2026-05-23T21:12:08.249830Z#x1B[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 1779570728.250 sable_ircd #x1B[2m2026-05-23T21:12:08.249916Z#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 synchronize603.577278759" 1779570728.250 sable_ircd #x1B[2m2026-05-23T21:12:08.250053Z#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 :synchronize603.577278759 1779570728.250 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize603.577278759 1779570728.486 sable_history #x1B[2m2027-05-23T22:29:39.436198Z#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(978424501622743126)), timestamp: 1811111379, clock: EventClock(1 => 978403601493790721, 50 => 978424249968697429), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811111379 }) }; event clock=EventClock(1 => 978403601493790721, 50 => 978424249968697429) my clock=EventClock(1 => 978403601493790721, 50 => 978424249968697429) 1779570728.486 sable_history #x1B[2m2027-05-23T22:29:39.437727Z#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 1779570728.527 sable_history #x1B[2m2027-05-23T22:38:03.653698Z#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(978426616466317408)), timestamp: 1811111883, clock: EventClock(1 => 978403954087956502, 50 => 978426364803883103, 99 => 978403957737402372), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811111883 }) }; event clock=EventClock(1 => 978403954087956502, 50 => 978426364803883103, 99 => 978403957737402372) my clock=EventClock(1 => 978403954087956502, 50 => 978426364803883103, 99 => 978403957737402372) 1779570728.527 sable_history #x1B[2m2027-05-23T22:38:03.655392Z#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 1779570728.952 3: connects to server. 1779570728.952 3 -> S: NICK nick3 1779570728.952 3 -> S: USER username * * :Realname 1779570728.952 sable_ircd #x1B[2m2026-05-23T21:12:08.952117Z#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 } 1779570728.952 sable_ircd #x1B[2m2026-05-23T21:12:08.952262Z#x1B[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 1779570728.952 sable_ircd #x1B[2m2026-05-23T21:12:08.952313Z#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 1779570728.952 sable_ircd #x1B[2m2026-05-23T21:12:08.952392Z#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 1779570728.953 sable_ircd #x1B[2m2026-05-23T21:12:08.952572Z#x1B[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 1779570728.953 sable_ircd #x1B[2m2026-05-23T21:12:08.952656Z#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"NICK nick3" 1779570728.953 S -> 3: :My.Little.Server NOTICE * :*** Looking up your hostname 1779570728.953 sable_ircd #x1B[2m2026-05-23T21:12:08.952787Z#x1B[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 1779570728.953 sable_ircd #x1B[2m2026-05-23T21:12:08.952866Z#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"USER username * * :Realname" 1779570728.953 sable_ircd #x1B[2m2026-05-23T21:12:08.952957Z#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: 604, tv_nsec: 280571534 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(), 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 1779570728.953 sable_ircd #x1B[2m2026-05-23T21:12:08.953038Z#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: 604, tv_nsec: 280571534 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick3")), 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 1779570728.953 sable_ircd #x1B[2m2026-05-23T21:12:08.953075Z#x1B[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 1779570728.954 sable_ircd #x1B[2m2026-05-23T21:12:08.953627Z#x1B[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 1779570728.954 sable_ircd #x1B[2m2026-05-23T21:12:08.953664Z#x1B[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")) 1779570728.954 sable_ircd #x1B[2m2026-05-23T21:12:08.953702Z#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 1779570728.954 sable_ircd #x1B[2m2026-05-23T21:12:08.953743Z#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: 604, tv_nsec: 280571534 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick3")), 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 1779570728.954 sable_ircd #x1B[2m2026-05-23T21:12:08.953832Z#x1B[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), 4)) 1779570728.954 sable_history #x1B[2m2027-05-23T22:29:40.204633Z#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(978424504843968599)), timestamp: 1811111380, clock: EventClock(1 => 978403603347673089, 50 => 978424253240254550, 99 => 978403608431570946), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811111380 }) }; event clock=EventClock(1 => 978403603347673089, 50 => 978424253240254550, 99 => 978403608431570946) my clock=EventClock(1 => 978403603347673089, 50 => 978424253240254550, 99 => 978403608431570946) 1779570728.954 sable_history #x1B[2m2027-05-23T22:29:40.206433Z#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 1779570728.954 sable_ircd #x1B[2m2026-05-23T21:12:08.954104Z#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(846133425147482116)), timestamp: 1779570728, clock: EventClock(1 => 846133421762678787), target: User(UserId(Snowflake(846133425143287812))), details: NewUser(NewUser { nickname: Nickname("nick3"), 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(846133425143287813)), NewUserConnection { user: UserId(Snowflake(846133425143287812)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1779570728 })) }) }; event clock=EventClock(1 => 846133421762678787) my clock=EventClock(1 => 846133421762678787) 1779570728.954 S -> 3: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1779570728.954 sable_ircd #x1B[2m2026-05-23T21:12:08.954205Z#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 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954513Z#x1B[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(846133425147482116)), timestamp: 1779570728, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(846133425143287812)), 1) }), users_to_notify: [] }) 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954556Z#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(846133425147482116)), timestamp: 1779570728, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(846133425143287812)), 1) }), users_to_notify: [] } 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954624Z#x1B[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(846133425147482116)), timestamp: 1779570728, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(846133425143287812)), 2), connection: UserConnectionId(Snowflake(846133425143287813)) }), users_to_notify: [] }) 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954657Z#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(846133425147482116)), timestamp: 1779570728, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(846133425143287812)), 2), connection: UserConnectionId(Snowflake(846133425143287813)) }), users_to_notify: [] } 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954727Z#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 001 nick3 :Welcome to the test Internet Relay Chat network, nick3 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954770Z#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 002 nick3 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954842Z#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 003 nick3 :This server was created 2026-05-23 21:12:08.954825171 UTC 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954887Z#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 004 nick3 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954940Z#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 005 nick3 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 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.954979Z#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 422 nick3 :MOTD File is missing 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.955023Z#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): :nick3!username@localhost MODE nick3 + 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.955058Z#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 nick3 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.955110Z#x1B[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(846133425147482116)), timestamp: 1779570728, change: EventComplete(EventComplete), users_to_notify: [] }) 1779570728.955 sable_ircd #x1B[2m2026-05-23T21:12:08.955142Z#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(846133425147482116)), timestamp: 1779570728, change: EventComplete(EventComplete), users_to_notify: [] } 1779570728.955 S -> 3: :My.Little.Server 001 nick3 :Welcome to the test Internet Relay Chat network, nick3 1779570728.955 S -> 3: :My.Little.Server 002 nick3 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1779570728.955 3 -> S: PING foo 1779570728.956 sable_ircd #x1B[2m2026-05-23T21:12:08.955712Z#x1B[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 1779570728.956 sable_ircd #x1B[2m2026-05-23T21:12:08.955753Z#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"PING foo" 1779570728.956 sable_ircd #x1B[2m2026-05-23T21:12:08.955845Z#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 PONG My.Little.Server :foo 1779570729.156 3 -> S: PING synchronize604.48394686 1779570729.156 S -> 3: :My.Little.Server 003 nick3 :This server was created 2026-05-23 21:12:08.954825171 UTC 1779570729.156 S -> 3: :My.Little.Server 004 nick3 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1779570729.156 S -> 3: :My.Little.Server 005 nick3 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 1779570729.156 S -> 3: :My.Little.Server 422 nick3 :MOTD File is missing 1779570729.156 S -> 3: :nick3!username@localhost MODE nick3 + 1779570729.156 S -> 3: :My.Little.Server NOTICE nick3 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1779570729.156 S -> 3: :My.Little.Server PONG My.Little.Server :foo 1779570729.156 sable_ircd #x1B[2m2026-05-23T21:12:09.156351Z#x1B[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 1779570729.156 sable_ircd #x1B[2m2026-05-23T21:12:09.156418Z#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"PING synchronize604.48394686" 1779570729.157 sable_ircd #x1B[2m2026-05-23T21:12:09.156544Z#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 PONG My.Little.Server :synchronize604.48394686 1779570729.157 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize604.48394686 1779570729.513 sable_history #x1B[2m2027-05-23T22:40:53.549158Z#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(978427329057595491)), timestamp: 1811112053, clock: EventClock(1 => 978403907443101718, 50 => 978427077399355490, 99 => 978403911423897604), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811112053 }) }; event clock=EventClock(1 => 978403907443101718, 50 => 978427077399355490, 99 => 978403911423897604) my clock=EventClock(1 => 978403907443101718, 50 => 978427077399355490, 99 => 978403911423897604) 1779570729.513 sable_history #x1B[2m2027-05-23T22:40:53.550607Z#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 1779570729.758 2 -> S: MODE nick2 -w 1779570729.758 sable_ircd #x1B[2m2026-05-23T21:12:09.758286Z#x1B[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 1779570729.758 sable_ircd #x1B[2m2026-05-23T21:12:09.758355Z#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"MODE nick2 -w" 1779570729.759 sable_ircd #x1B[2m2026-05-23T21:12:09.758544Z#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 472 nick2 w :Unknown mode character 1779570729.759 sable_ircd #x1B[2m2026-05-23T21:12:09.758591Z#x1B[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 1779570729.858 2 -> S: PING synchronize605.186223634 1779570729.858 S -> 2: :My.Little.Server 472 nick2 w :Unknown mode character 1779570729.859 sable_ircd #x1B[2m2026-05-23T21:12:09.858702Z#x1B[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 1779570729.859 sable_ircd #x1B[2m2026-05-23T21:12:09.858770Z#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 synchronize605.186223634" 1779570730.110 sable_ircd #x1B[2m2026-05-23T21:12:10.109645Z#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 :synchronize605.186223634 1779570730.110 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize605.186223634 1779570730.110 3 -> S: MODE nick3 +w 1779570730.110 sable_ircd #x1B[2m2026-05-23T21:12:10.110444Z#x1B[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 1779570730.111 sable_ircd #x1B[2m2026-05-23T21:12:10.110485Z#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"MODE nick3 +w" 1779570730.111 sable_ircd #x1B[2m2026-05-23T21:12:10.110607Z#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 472 nick3 w :Unknown mode character 1779570730.111 sable_ircd #x1B[2m2026-05-23T21:12:10.110663Z#x1B[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 1779570730.126 sable_history #x1B[2m2027-05-23T22:29:41.146764Z#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(978424508795002967)), timestamp: 1811111381, clock: EventClock(1 => 978403680887771151, 50 => 978424257136762966, 99 => 978403670863785988), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811111381 }) }; event clock=EventClock(1 => 978403680887771151, 50 => 978424257136762966, 99 => 978403670863785988) my clock=EventClock(1 => 978403680887771151, 50 => 978424257136762966, 99 => 978403670863785988) 1779570730.126 sable_history #x1B[2m2027-05-23T22:29:41.148459Z#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 1779570730.210 3 -> S: PING synchronize605.538520285 1779570730.210 S -> 3: :My.Little.Server 472 nick3 w :Unknown mode character 1779570730.211 sable_ircd #x1B[2m2026-05-23T21:12:10.211037Z#x1B[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 1779570730.211 sable_ircd #x1B[2m2026-05-23T21:12:10.211110Z#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"PING synchronize605.538520285" 1779570730.211 sable_ircd #x1B[2m2026-05-23T21:12:10.211237Z#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 PONG My.Little.Server :synchronize605.538520285 1779570730.212 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize605.538520285 1779570730.212 1 -> S: OPER operuser operpassword 1779570730.212 sable_ircd #x1B[2m2026-05-23T21:12:10.211852Z#x1B[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 1779570730.212 sable_ircd #x1B[2m2026-05-23T21:12:10.211912Z#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"OPER operuser operpassword" 1779570730.272 sable_ircd #x1B[2m2026-05-23T21:12:10.272006Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2maudit#x1B[0m#x1B[2m:#x1B[0m #x1B[3mid#x1B[0m#x1B[2m=#x1B[0mAuditLogEntryId(Snowflake(846133430671380486)) #x1B[3mcategory#x1B[0m#x1B[2m=#x1B[0mGeneral #x1B[3mtimestamp#x1B[0m#x1B[2m=#x1B[0m1779570730 #x1B[3msource_id#x1B[0m#x1B[2m=#x1B[0mSome(UserId(Snowflake(846133418382069760))) #x1B[3msource_addr#x1B[0m#x1B[2m=#x1B[0mSome(127.0.0.1) #x1B[3msource_str#x1B[0m#x1B[2m=#x1B[0m"nick1!username@localhost[]{127.0.0.1}" #x1B[3maction#x1B[0m#x1B[2m=#x1B[0m"OPER" #x1B[3mtarget_id#x1B[0m#x1B[2m=#x1B[0mNone 1779570730.272 sable_ircd #x1B[2m2026-05-23T21:12:10.272113Z#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 381 nick1 :You are now an IRC operator 1779570730.272 sable_ircd #x1B[2m2026-05-23T21:12:10.272240Z#x1B[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(846133418382069760))), OperUp(OperUp { oper_name: "operuser" })) 1779570730.272 sable_ircd #x1B[2m2026-05-23T21:12:10.272302Z#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(846133430675574789)), timestamp: 1779570730, clock: EventClock(1 => 846133425147482116), target: AuditLogEntry(AuditLogEntryId(Snowflake(846133430671380486))), details: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntry { id: AuditLogEntryId(Snowflake(846133430671380486)), timestamp: 1779570730, category: General, source_id: Some(UserId(Snowflake(846133418382069760))), source_addr: Some(127.0.0.1), source_str: "nick1!username@localhost[]{127.0.0.1}", action: "OPER", target_id: None, target_str: None, target_duration: None, reason: None } }) }; event clock=EventClock(1 => 846133425147482116) my clock=EventClock(1 => 846133425147482116) 1779570730.272 sable_ircd #x1B[2m2026-05-23T21:12:10.272398Z#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 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.272480Z#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(846133430675574790)), timestamp: 1779570730, clock: EventClock(1 => 846133430675574789), target: User(UserId(Snowflake(846133418382069760))), details: OperUp(OperUp { oper_name: "operuser" }) }; event clock=EventClock(1 => 846133430675574789) my clock=EventClock(1 => 846133430675574789) 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.272535Z#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 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.272902Z#x1B[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(846133430675574789)), timestamp: 1779570730, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(846133430671380486)) }), users_to_notify: [] }) 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.272937Z#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(846133430675574789)), timestamp: 1779570730, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(846133430671380486)) }), users_to_notify: [] } 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.272994Z#x1B[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(846133430675574789)), timestamp: 1779570730, change: EventComplete(EventComplete), users_to_notify: [] }) 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.273019Z#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(846133430675574789)), timestamp: 1779570730, change: EventComplete(EventComplete), users_to_notify: [] } 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.273062Z#x1B[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(846133430675574790)), timestamp: 1779570730, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(846133418382069760)), 2), added: UserModeSet(2), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(846133418382069760)), 2)) }), users_to_notify: [UserId(Snowflake(846133418382069760))] }) 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.273092Z#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(846133430675574790)), timestamp: 1779570730, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(846133418382069760)), 2), added: UserModeSet(2), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(846133418382069760)), 2)) }), users_to_notify: [UserId(Snowflake(846133418382069760))] } 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.273152Z#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): :nick1!username@localhost MODE nick1 +o 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.273203Z#x1B[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(846133430675574790)), timestamp: 1779570730, change: EventComplete(EventComplete), users_to_notify: [] }) 1779570730.273 sable_ircd #x1B[2m2026-05-23T21:12:10.273226Z#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(846133430675574790)), timestamp: 1779570730, change: EventComplete(EventComplete), users_to_notify: [] } 1779570730.312 1 -> S: PING synchronize605.639928569 1779570730.312 S -> 1: :My.Little.Server 381 nick1 :You are now an IRC operator 1779570730.312 S -> 1: :nick1!username@localhost MODE nick1 +o 1779570730.312 sable_ircd #x1B[2m2026-05-23T21:12:10.312404Z#x1B[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 1779570730.313 sable_ircd #x1B[2m2026-05-23T21:12:10.312482Z#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 synchronize605.639928569" 1779570730.313 sable_ircd #x1B[2m2026-05-23T21:12:10.312645Z#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 :synchronize605.639928569 1779570730.313 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize605.639928569 1779570730.313 1 -> S: WALLOPS :hi everyone 1779570730.313 sable_ircd #x1B[2m2026-05-23T21:12:10.313307Z#x1B[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 1779570730.313 sable_ircd #x1B[2m2026-05-23T21:12:10.313358Z#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"WALLOPS :hi everyone" 1779570730.314 sable_ircd #x1B[2m2026-05-23T21:12:10.313470Z#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 421 nick1 WALLOPS :Unknown command 1779570730.331 sable_history #x1B[2m2027-05-23T22:43:49.857889Z#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(978428068551139430)), timestamp: 1811112229, clock: EventClock(1 => 978403858424270870, 50 => 978427816892899429, 99 => 978403864317669380), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811112229 }) }; event clock=EventClock(1 => 978403858424270870, 50 => 978427816892899429, 99 => 978403864317669380) my clock=EventClock(1 => 978403858424270870, 50 => 978427816892899429, 99 => 978403864317669380) 1779570730.331 sable_history #x1B[2m2027-05-23T22:43:49.859477Z#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 1779570730.413 1 -> S: PING synchronize605.741385333 1779570730.413 S -> 1: :My.Little.Server 421 nick1 WALLOPS :Unknown command 1779570730.414 sable_ircd #x1B[2m2026-05-23T21:12:10.413814Z#x1B[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 1779570730.414 sable_ircd #x1B[2m2026-05-23T21:12:10.413889Z#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 synchronize605.741385333" 1779570730.828 sable_history #x1B[2m2027-05-23T22:33:25.899070Z#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(978425451477409883)), timestamp: 1811111605, clock: EventClock(1 => 978404299149152289, 50 => 978425199819169882, 99 => 978404302303670277), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811111605 }) }; event clock=EventClock(1 => 978404299149152289, 50 => 978425199819169882, 99 => 978404302303670277) my clock=EventClock(1 => 978404299149152289, 50 => 978425199819169882, 99 => 978404302303670277) 1779570730.828 sable_history #x1B[2m2027-05-23T22:33:25.900559Z#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 1779570731.053 sable_history #x1B[2m2027-05-23T22:30:38.018388Z#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(978424747333460055)), timestamp: 1811111438, clock: EventClock(1 => 978403595609182209, 50 => 978424495666831446), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1811111438 }) }; event clock=EventClock(1 => 978403595609182209, 50 => 978424495666831446) my clock=EventClock(1 => 978403595609182209, 50 => 978424495666831446) 1779570731.053 sable_history #x1B[2m2027-05-23T22:30:38.020809Z#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 1779570731.168 sable_ircd #x1B[2m2026-05-23T21:12:11.167956Z#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 :synchronize605.741385333 1779570731.168 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize605.741385333 1779570731.172 1: disconnects from server. 1779570731.172 2: disconnects from server. 1779570731.172 3: disconnects from server.