--------------------------------- Captured Out ---------------------------------
---- new test ----
1788127930.151 sable_ircd     uid=1001
1788127930.154 sable_ircd     #x1B[2m2026-08-30T22:12:10.153752Z#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(882024928365252608)), timestamp: 1788127930, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127930, name: ServerName("My.Little.Server"), ts: 1788127930, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1788127930.154 sable_ircd     #x1B[2m2026-08-30T22:12:10.153847Z#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
1788127930.154 sable_ircd     #x1B[2m2026-08-30T22:12:10.153994Z#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(882024928365252608)), timestamp: 1788127930, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127930, name: ServerName("My.Little.Server"), ts: 1788127930, 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
1788127930.154 sable_ircd     #x1B[2m2026-08-30T22:12:10.154069Z#x1B[0m #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(882024928365252608)), timestamp: 1788127930, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1788127930.154 sable_ircd     #x1B[2m2026-08-30T22:12:10.154096Z#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(882024928365252608)), timestamp: 1788127930, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1788127930.154 sable_ircd     #x1B[2m2026-08-30T22:12:10.154129Z#x1B[0m #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(882024928365252608)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] })
1788127930.154 sable_ircd     #x1B[2m2026-08-30T22:12:10.154152Z#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(882024928365252608)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] }
1788127930.155 sable_ircd     #x1B[2m2026-08-30T22:12:10.155330Z#x1B[0m #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
1788127930.155 sable_ircd     #x1B[2m2026-08-30T22:12:10.155405Z#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(882024928373641217)), timestamp: 1788127930, clock: EventClock(1 => 882024928365252608), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127930 }) }; event clock=EventClock(1 => 882024928365252608) my clock=EventClock(1 => 882024928365252608)
1788127930.155 sable_ircd     #x1B[2m2026-08-30T22:12:10.155449Z#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
1788127930.156 sable_ircd     #x1B[2m2026-08-30T22:12:10.155570Z#x1B[0m #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(882024928373641217)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] })
1788127930.156 sable_ircd     #x1B[2m2026-08-30T22:12:10.155589Z#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(882024928373641217)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] }
1788127930.248 sable_ircd     #x1B[2m2026-08-30T22:12:10.247663Z#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 }
1788127930.248 sable_ircd     #x1B[2m2026-08-30T22:12:10.247786Z#x1B[0m #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
1788127930.248 sable_ircd     #x1B[2m2026-08-30T22:12:10.247829Z#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
1788127930.248 sable_ircd     #x1B[2m2026-08-30T22:12:10.247894Z#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
1788127930.248 sable_ircd     #x1B[2m2026-08-30T22:12:10.248023Z#x1B[0m #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
1788127930.248 sable_ircd     #x1B[2m2026-08-30T22:12:10.248072Z#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"
1788127930.248 sable_ircd     #x1B[2m2026-08-30T22:12:10.248154Z#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
1788127930.248 sable_ircd     #x1B[2m2026-08-30T22:12:10.248223Z#x1B[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))
1788127930.248 sable_ircd     #x1B[2m2026-08-30T22:12:10.248246Z#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)
1788127930.249 sable_ircd     #x1B[2m2026-08-30T22:12:10.248559Z#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
1788127930.249 sable_ircd     #x1B[2m2026-08-30T22:12:10.248618Z#x1B[0m #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
1788127930.249 sable_ircd     #x1B[2m2026-08-30T22:12:10.248770Z#x1B[0m #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
1788127930.268 1: connects to server.
1788127930.268 1 -> S: NICK coolNick
1788127930.268 1 -> S: USER myusernam 0 * :My UniqueReal Name
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.268689Z#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 }
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.268795Z#x1B[0m #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
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.268822Z#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
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.268858Z#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
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.268940Z#x1B[0m #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
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.268976Z#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"
1788127930.269 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.269097Z#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: 576, tv_nsec: 390464703 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("coolNick")), realname: OnceLock(<uninit>), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.269151Z#x1B[0m #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
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.269184Z#x1B[0m #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
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.269214Z#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"
1788127930.269 sable_ircd     #x1B[2m2026-08-30T22:12:10.269275Z#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: 576, tv_nsec: 390464703 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("myusernam")), extra_user_params: OnceLock(("0", "*")), nick: OnceLock(Nickname("coolNick")), realname: OnceLock(Realname("My UniqueReal Name")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.269685Z#x1B[0m #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
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.269712Z#x1B[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"))
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.269732Z#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
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.269747Z#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: 576, tv_nsec: 390464703 }, attach_user_id: OnceLock(<uninit>), 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(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.269780Z#x1B[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))
1788127930.270 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.269987Z#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(882024928851791874)), timestamp: 1788127930, clock: EventClock(1 => 882024928373641217), target: User(UserId(Snowflake(882024928851791872))), 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(882024928851791873)), NewUserConnection { user: UserId(Snowflake(882024928851791872)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127930 })) }) }; event clock=EventClock(1 => 882024928373641217) my clock=EventClock(1 => 882024928373641217)
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270066Z#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
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270271Z#x1B[0m #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(882024928851791874)), timestamp: 1788127930, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024928851791872)), 1) }), users_to_notify: [] })
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270296Z#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(882024928851791874)), timestamp: 1788127930, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024928851791872)), 1) }), users_to_notify: [] }
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270330Z#x1B[0m #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(882024928851791874)), timestamp: 1788127930, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024928851791872)), 2), connection: UserConnectionId(Snowflake(882024928851791873)) }), users_to_notify: [] })
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270344Z#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(882024928851791874)), timestamp: 1788127930, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024928851791872)), 2), connection: UserConnectionId(Snowflake(882024928851791873)) }), users_to_notify: [] }
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270399Z#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
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270419Z#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
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270433Z#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:10.270427186 UTC
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270444Z#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
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270468Z#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
1788127930.270 sable_ircd     #x1B[2m2026-08-30T22:12:10.270480Z#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
1788127930.271 sable_ircd     #x1B[2m2026-08-30T22:12:10.270491Z#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 +
1788127930.271 sable_ircd     #x1B[2m2026-08-30T22:12:10.270500Z#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.
1788127930.271 sable_ircd     #x1B[2m2026-08-30T22:12:10.270520Z#x1B[0m #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(882024928851791874)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] })
1788127930.271 sable_ircd     #x1B[2m2026-08-30T22:12:10.270531Z#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(882024928851791874)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] }
1788127930.271 S -> 1: :My.Little.Server 001 coolNick :Welcome to the test Internet Relay Chat network, coolNick
1788127930.371 1 -> S: PING synchronize576.492459842
1788127930.371 S -> 1: :My.Little.Server 002 coolNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127930.371 S -> 1: :My.Little.Server 003 coolNick :This server was created 2026-08-30 22:12:10.270427186 UTC
1788127930.371 S -> 1: :My.Little.Server 004 coolNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127930.371 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
1788127930.371 S -> 1: :My.Little.Server 422 coolNick :MOTD File is missing
1788127930.371 S -> 1: :coolNick!myusernam@localhost MODE coolNick +
1788127930.371 S -> 1: :My.Little.Server NOTICE coolNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127930.371 sable_ircd     #x1B[2m2026-08-30T22:12:10.371340Z#x1B[0m #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
1788127930.371 sable_ircd     #x1B[2m2026-08-30T22:12:10.371409Z#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 synchronize576.492459842"
1788127930.372 sable_ircd     #x1B[2m2026-08-30T22:12:10.371518Z#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 :synchronize576.492459842
1788127930.372 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize576.492459842
1788127930.372 1 -> S: JOIN #chan
1788127930.372 sable_ircd     #x1B[2m2026-08-30T22:12:10.371939Z#x1B[0m #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
1788127930.372 sable_ircd     #x1B[2m2026-08-30T22:12:10.371967Z#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"
1788127930.372 sable_ircd     #x1B[2m2026-08-30T22:12:10.372160Z#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(882024929283805187)), timestamp: 1788127930, clock: EventClock(1 => 882024928851791874), target: Channel(ChannelId(Snowflake(882024929283805186))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 882024928851791874) my clock=EventClock(1 => 882024928851791874)
1788127930.372 sable_ircd     #x1B[2m2026-08-30T22:12:10.372297Z#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
1788127930.372 sable_ircd     #x1B[2m2026-08-30T22:12:10.372363Z#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(882024929283805188)), timestamp: 1788127930, clock: EventClock(1 => 882024929283805187), target: Membership(MembershipId(UserId(Snowflake(882024928851791872)), ChannelId(Snowflake(882024929283805186)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024929283805186)), user: UserId(Snowflake(882024928851791872)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 882024929283805187) my clock=EventClock(1 => 882024929283805187)
1788127930.372 sable_ircd     #x1B[2m2026-08-30T22:12:10.372462Z#x1B[0m #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
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372519Z#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
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372663Z#x1B[0m #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(882024929283805187)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] })
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372689Z#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(882024929283805187)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] }
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372718Z#x1B[0m #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(882024929283805188)), timestamp: 1788127930, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024928851791872)), ChannelId(Snowflake(882024929283805186))), user: HistoricUserId(UserId(Snowflake(882024928851791872)), 2) }), users_to_notify: [UserId(Snowflake(882024928851791872))] })
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372733Z#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(882024929283805188)), timestamp: 1788127930, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024928851791872)), ChannelId(Snowflake(882024929283805186))), user: HistoricUserId(UserId(Snowflake(882024928851791872)), 2) }), users_to_notify: [UserId(Snowflake(882024928851791872))] }
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372776Z#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
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372800Z#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
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372827Z#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
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372839Z#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
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372859Z#x1B[0m #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(882024929283805188)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] })
1788127930.373 sable_ircd     #x1B[2m2026-08-30T22:12:10.372870Z#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(882024929283805188)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] }
1788127930.472 1 -> S: PING synchronize576.593527591
1788127930.472 S -> 1: :coolNick!myusernam@localhost JOIN #chan
1788127930.472 S -> 1: :coolNick!myusernam@localhost MODE #chan +o coolNick
1788127930.472 S -> 1: :My.Little.Server 353 coolNick = #chan :@coolNick
1788127930.472 S -> 1: :My.Little.Server 366 coolNick #chan :End of names list
1788127930.472 sable_ircd     #x1B[2m2026-08-30T22:12:10.472374Z#x1B[0m #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
1788127930.472 sable_ircd     #x1B[2m2026-08-30T22:12:10.472439Z#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 synchronize576.593527591"
1788127930.713 sable_ircd     #x1B[2m2026-08-30T22:12:10.712439Z#x1B[0m #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
1788127930.713 sable_ircd     #x1B[2m2026-08-30T22:12:10.712553Z#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(882024930709868554)), timestamp: 1788127930, clock: EventClock(1 => 882024679047434249), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127930 }) }; event clock=EventClock(1 => 882024679047434249) my clock=EventClock(1 => 882024679047434249)
1788127930.713 sable_ircd     #x1B[2m2026-08-30T22:12:10.712627Z#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
1788127930.713 sable_ircd     #x1B[2m2026-08-30T22:12:10.712795Z#x1B[0m #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(882024930709868554)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] })
1788127930.713 sable_ircd     #x1B[2m2026-08-30T22:12:10.712826Z#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(882024930709868554)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] }
1788127931.225 sable_ircd     #x1B[2m2026-08-30T22:12:11.225021Z#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 :synchronize576.593527591
1788127931.225 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize576.593527591
1788127931.225 2: connects to server.
1788127931.226 2 -> S: NICK otherNick
1788127931.226 2 -> S: USER username * * :Realname
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.225669Z#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 }
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.225754Z#x1B[0m #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
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.225780Z#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
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.225818Z#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
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.225906Z#x1B[0m #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
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.225938Z#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"
1788127931.226 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.226054Z#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: 577, tv_nsec: 347427275 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("otherNick")), realname: OnceLock(<uninit>), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.226096Z#x1B[0m #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
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.226120Z#x1B[0m #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
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.226139Z#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"
1788127931.226 sable_ircd     #x1B[2m2026-08-30T22:12:11.226187Z#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: 577, tv_nsec: 347427275 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("otherNick")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.226701Z#x1B[0m #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
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.226728Z#x1B[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"))
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.226754Z#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
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.226773Z#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: 577, tv_nsec: 347427275 }, attach_user_id: OnceLock(<uninit>), 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(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.226812Z#x1B[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))
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.226986Z#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(882024932865740805)), timestamp: 1788127931, clock: EventClock(1 => 882024929283805188), target: User(UserId(Snowflake(882024932865740803))), 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(882024932865740804)), NewUserConnection { user: UserId(Snowflake(882024932865740803)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127931 })) }) }; event clock=EventClock(1 => 882024929283805188) my clock=EventClock(1 => 882024929283805188)
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227056Z#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
1788127931.227 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227245Z#x1B[0m #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(882024932865740805)), timestamp: 1788127931, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024932865740803)), 1) }), users_to_notify: [] })
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227272Z#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(882024932865740805)), timestamp: 1788127931, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024932865740803)), 1) }), users_to_notify: [] }
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227301Z#x1B[0m #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(882024932865740805)), timestamp: 1788127931, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024932865740803)), 2), connection: UserConnectionId(Snowflake(882024932865740804)) }), users_to_notify: [] })
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227314Z#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(882024932865740805)), timestamp: 1788127931, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024932865740803)), 2), connection: UserConnectionId(Snowflake(882024932865740804)) }), users_to_notify: [] }
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227344Z#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
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227359Z#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
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227373Z#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:11.227368487 UTC
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227404Z#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
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227417Z#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
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227428Z#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
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227440Z#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 +
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227450Z#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.
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227476Z#x1B[0m #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(882024932865740805)), timestamp: 1788127931, change: EventComplete(EventComplete), users_to_notify: [] })
1788127931.227 sable_ircd     #x1B[2m2026-08-30T22:12:11.227487Z#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(882024932865740805)), timestamp: 1788127931, change: EventComplete(EventComplete), users_to_notify: [] }
1788127931.228 S -> 2: :My.Little.Server 001 otherNick :Welcome to the test Internet Relay Chat network, otherNick
1788127931.228 S -> 2: :My.Little.Server 002 otherNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127931.228 S -> 2: :My.Little.Server 003 otherNick :This server was created 2026-08-30 22:12:11.227368487 UTC
1788127931.228 S -> 2: :My.Little.Server 004 otherNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127931.228 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
1788127931.228 S -> 2: :My.Little.Server 422 otherNick :MOTD File is missing
1788127931.228 S -> 2: :otherNick!username@localhost MODE otherNick +
1788127931.228 S -> 2: :My.Little.Server NOTICE otherNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127931.228 2 -> S: PING foo
1788127931.228 sable_ircd     #x1B[2m2026-08-30T22:12:11.227996Z#x1B[0m #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
1788127931.228 sable_ircd     #x1B[2m2026-08-30T22:12:11.228026Z#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"
1788127931.228 sable_ircd     #x1B[2m2026-08-30T22:12:11.228075Z#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
1788127931.644 sable_ircd     #x1B[2m2026-08-30T22:12:11.643591Z#x1B[0m #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
1788127931.644 sable_ircd     #x1B[2m2026-08-30T22:12:11.643646Z#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(882024934614765578)), timestamp: 1788127931, clock: EventClock(1 => 882024682956525577), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127931 }) }; event clock=EventClock(1 => 882024682956525577) my clock=EventClock(1 => 882024682956525577)
1788127931.644 sable_ircd     #x1B[2m2026-08-30T22:12:11.643709Z#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
1788127931.644 sable_ircd     #x1B[2m2026-08-30T22:12:11.643868Z#x1B[0m #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(882024934614765578)), timestamp: 1788127931, change: EventComplete(EventComplete), users_to_notify: [] })
1788127931.644 sable_ircd     #x1B[2m2026-08-30T22:12:11.643905Z#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(882024934614765578)), timestamp: 1788127931, change: EventComplete(EventComplete), users_to_notify: [] }
1788127932.029 2 -> S: PING synchronize578.150350327
1788127932.029 S -> 2: :My.Little.Server PONG My.Little.Server :foo
1788127932.029 sable_ircd     #x1B[2m2026-08-30T22:12:12.029131Z#x1B[0m #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
1788127932.029 sable_ircd     #x1B[2m2026-08-30T22:12:12.029178Z#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 synchronize578.150350327"
1788127932.029 sable_ircd     #x1B[2m2026-08-30T22:12:12.029267Z#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 :synchronize578.150350327
1788127932.029 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize578.150350327
1788127932.130 2 -> S: PING synchronize578.251264219
1788127932.130 sable_ircd     #x1B[2m2026-08-30T22:12:12.130129Z#x1B[0m #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
1788127932.130 sable_ircd     #x1B[2m2026-08-30T22:12:12.130179Z#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 synchronize578.251264219"
1788127932.130 sable_ircd     #x1B[2m2026-08-30T22:12:12.130278Z#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 :synchronize578.251264219
1788127932.130 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize578.251264219
1788127932.131 2 -> S: JOIN #chan
1788127932.131 sable_ircd     #x1B[2m2026-08-30T22:12:12.130734Z#x1B[0m #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
1788127932.131 sable_ircd     #x1B[2m2026-08-30T22:12:12.130763Z#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"
1788127932.231 2 -> S: PING synchronize578.352301691
1788127932.231 sable_ircd     #x1B[2m2026-08-30T22:12:12.231216Z#x1B[0m #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
1788127932.231 sable_ircd     #x1B[2m2026-08-30T22:12:12.231273Z#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 synchronize578.352301691"
1788127932.827 sable_ircd     #x1B[2m2026-08-30T22:12:12.826924Z#x1B[0m #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
1788127932.827 sable_ircd     #x1B[2m2026-08-30T22:12:12.827024Z#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(882024939576627210)), timestamp: 1788127932, clock: EventClock(1 => 882024687922581513), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127932 }) }; event clock=EventClock(1 => 882024687922581513) my clock=EventClock(1 => 882024687922581513)
1788127932.827 sable_ircd     #x1B[2m2026-08-30T22:12:12.827099Z#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
1788127932.827 sable_ircd     #x1B[2m2026-08-30T22:12:12.827287Z#x1B[0m #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(882024939576627210)), timestamp: 1788127932, change: EventComplete(EventComplete), users_to_notify: [] })
1788127932.827 sable_ircd     #x1B[2m2026-08-30T22:12:12.827319Z#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(882024939576627210)), timestamp: 1788127932, change: EventComplete(EventComplete), users_to_notify: [] }
1788127933.232 2: waiting…
1788127933.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.235680Z#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(882024941292097542)), timestamp: 1788127933, clock: EventClock(1 => 882024932865740805), target: Membership(MembershipId(UserId(Snowflake(882024932865740803)), ChannelId(Snowflake(882024929283805186)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024929283805186)), user: UserId(Snowflake(882024932865740803)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882024932865740805) my clock=EventClock(1 => 882024932865740805)
1788127933.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.235807Z#x1B[0m #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.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.235808Z#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.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.235995Z#x1B[0m #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(882024941292097542)), timestamp: 1788127933, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024932865740803)), ChannelId(Snowflake(882024929283805186))), user: HistoricUserId(UserId(Snowflake(882024932865740803)), 2) }), users_to_notify: [UserId(Snowflake(882024932865740803)), UserId(Snowflake(882024928851791872))] })
1788127933.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.236024Z#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(882024941292097542)), timestamp: 1788127933, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024932865740803)), ChannelId(Snowflake(882024929283805186))), user: HistoricUserId(UserId(Snowflake(882024932865740803)), 2) }), users_to_notify: [UserId(Snowflake(882024932865740803)), UserId(Snowflake(882024928851791872))] }
1788127933.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.236068Z#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
1788127933.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.236104Z#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 :otherNick @coolNick
1788127933.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.236116Z#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
1788127933.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.236130Z#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
1788127933.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.236153Z#x1B[0m #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(882024941292097542)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] })
1788127933.236 sable_ircd     #x1B[2m2026-08-30T22:12:13.236164Z#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(882024941292097542)), timestamp: 1788127933, change: EventComplete(EventComplete), users_to_notify: [] }
1788127933.236 S -> 2: :otherNick!username@localhost JOIN #chan
1788127933.277 S -> 2: :My.Little.Server 353 otherNick = #chan :otherNick @coolNick
1788127933.278 S -> 2: :My.Little.Server 366 otherNick #chan :End of names list
1788127934.241 sable_ircd     #x1B[2m2026-08-30T22:12:14.240588Z#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 :synchronize578.352301691
1788127934.241 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize578.352301691
1788127934.241 2 -> S: WHO coolnick
1788127934.241 sable_ircd     #x1B[2m2026-08-30T22:12:14.241259Z#x1B[0m #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.241 sable_ircd     #x1B[2m2026-08-30T22:12:14.241300Z#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"
1788127934.341 2 -> S: PING synchronize580.462808967
1788127934.342 sable_ircd     #x1B[2m2026-08-30T22:12:14.341679Z#x1B[0m #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.342 sable_ircd     #x1B[2m2026-08-30T22:12:14.341741Z#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 synchronize580.462808967"
1788127935.096 sable_ircd     #x1B[2m2026-08-30T22:12:15.095506Z#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 H :0 My UniqueReal Name
1788127935.096 sable_ircd     #x1B[2m2026-08-30T22:12:15.095557Z#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
1788127935.096 S -> 2: :My.Little.Server 352 otherNick * myusernam localhost * coolNick H :0 My UniqueReal Name
1788127935.136 S -> 2: :My.Little.Server 315 otherNick coolnick :End of /WHO list
1788127936.100 sable_ircd     #x1B[2m2026-08-30T22:12:16.099722Z#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 :synchronize580.462808967
1788127936.100 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize580.462808967
1788127936.106 1: disconnects from server.
1788127936.106 2: disconnects from server.