--------------------------------- Captured Out ---------------------------------
---- new test ----
1788127926.131 sable_ircd     uid=1001
1788127926.134 sable_ircd     #x1B[2m2026-08-30T22:12:06.134240Z#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(882024911508344832)), timestamp: 1788127926, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127926, name: ServerName("My.Little.Server"), ts: 1788127926, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1788127926.135 sable_ircd     #x1B[2m2026-08-30T22:12:06.134354Z#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
1788127926.135 sable_ircd     #x1B[2m2026-08-30T22:12:06.134522Z#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(882024911508344832)), timestamp: 1788127926, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127926, name: ServerName("My.Little.Server"), ts: 1788127926, 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
1788127926.135 sable_ircd     #x1B[2m2026-08-30T22:12:06.134655Z#x1B[0m #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(882024911508344832)), timestamp: 1788127926, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1788127926.135 sable_ircd     #x1B[2m2026-08-30T22:12:06.134685Z#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(882024911508344832)), timestamp: 1788127926, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1788127926.135 sable_ircd     #x1B[2m2026-08-30T22:12:06.134713Z#x1B[0m #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(882024911508344832)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] })
1788127926.135 sable_ircd     #x1B[2m2026-08-30T22:12:06.134730Z#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(882024911508344832)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] }
1788127926.135 sable_ircd     #x1B[2m2026-08-30T22:12:06.135222Z#x1B[0m #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
1788127926.135 sable_ircd     #x1B[2m2026-08-30T22:12:06.135281Z#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(882024911512539137)), timestamp: 1788127926, clock: EventClock(1 => 882024911508344832), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127926 }) }; event clock=EventClock(1 => 882024911508344832) my clock=EventClock(1 => 882024911508344832)
1788127926.135 sable_ircd     #x1B[2m2026-08-30T22:12:06.135336Z#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
1788127926.136 sable_ircd     #x1B[2m2026-08-30T22:12:06.135502Z#x1B[0m #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(882024911512539137)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] })
1788127926.136 sable_ircd     #x1B[2m2026-08-30T22:12:06.135527Z#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(882024911512539137)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] }
1788127926.228 sable_ircd     #x1B[2m2026-08-30T22:12:06.227729Z#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 }
1788127926.228 sable_ircd     #x1B[2m2026-08-30T22:12:06.227865Z#x1B[0m #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
1788127926.228 sable_ircd     #x1B[2m2026-08-30T22:12:06.227909Z#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
1788127926.228 sable_ircd     #x1B[2m2026-08-30T22:12:06.227982Z#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
1788127926.228 sable_ircd     #x1B[2m2026-08-30T22:12:06.228120Z#x1B[0m #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
1788127926.228 sable_ircd     #x1B[2m2026-08-30T22:12:06.228167Z#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"
1788127926.228 sable_ircd     #x1B[2m2026-08-30T22:12:06.228270Z#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
1788127926.228 sable_ircd     #x1B[2m2026-08-30T22:12:06.228347Z#x1B[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))
1788127926.228 sable_ircd     #x1B[2m2026-08-30T22:12:06.228376Z#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)
1788127926.229 sable_ircd     #x1B[2m2026-08-30T22:12:06.228713Z#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
1788127926.229 sable_ircd     #x1B[2m2026-08-30T22:12:06.228795Z#x1B[0m #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
1788127926.229 sable_ircd     #x1B[2m2026-08-30T22:12:06.228973Z#x1B[0m #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
1788127926.249 1: connects to server.
1788127926.249 1 -> S: NICK coolNick
1788127926.249 1 -> S: USER myusernam 0 * :My UniqueReal Name
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.248796Z#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 }
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.248897Z#x1B[0m #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
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.248923Z#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
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.248959Z#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
1788127926.249 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.249047Z#x1B[0m #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
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.249080Z#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"
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.249218Z#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: 572, tv_nsec: 370565698 }, 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
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.249272Z#x1B[0m #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
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.249300Z#x1B[0m #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
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.249316Z#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"
1788127926.249 sable_ircd     #x1B[2m2026-08-30T22:12:06.249365Z#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: 572, tv_nsec: 370565698 }, 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
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.249723Z#x1B[0m #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
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.249750Z#x1B[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"))
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.249769Z#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
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.249784Z#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: 572, tv_nsec: 370565698 }, 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
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.249816Z#x1B[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))
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.250005Z#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(882024911990689794)), timestamp: 1788127926, clock: EventClock(1 => 882024911512539137), target: User(UserId(Snowflake(882024911990689792))), 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(882024911990689793)), NewUserConnection { user: UserId(Snowflake(882024911990689792)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127926 })) }) }; event clock=EventClock(1 => 882024911512539137) my clock=EventClock(1 => 882024911512539137)
1788127926.250 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.250087Z#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
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.250320Z#x1B[0m #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(882024911990689794)), timestamp: 1788127926, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024911990689792)), 1) }), users_to_notify: [] })
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.250351Z#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(882024911990689794)), timestamp: 1788127926, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024911990689792)), 1) }), users_to_notify: [] }
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.250404Z#x1B[0m #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(882024911990689794)), timestamp: 1788127926, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024911990689792)), 2), connection: UserConnectionId(Snowflake(882024911990689793)) }), users_to_notify: [] })
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.250420Z#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(882024911990689794)), timestamp: 1788127926, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024911990689792)), 2), connection: UserConnectionId(Snowflake(882024911990689793)) }), users_to_notify: [] }
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.250456Z#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
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.250471Z#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
1788127926.250 sable_ircd     #x1B[2m2026-08-30T22:12:06.250485Z#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:06.250478608 UTC
1788127926.251 sable_ircd     #x1B[2m2026-08-30T22:12:06.250500Z#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
1788127926.251 sable_ircd     #x1B[2m2026-08-30T22:12:06.250521Z#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
1788127926.251 sable_ircd     #x1B[2m2026-08-30T22:12:06.250533Z#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
1788127926.251 sable_ircd     #x1B[2m2026-08-30T22:12:06.250545Z#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 +
1788127926.251 sable_ircd     #x1B[2m2026-08-30T22:12:06.250555Z#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.
1788127926.251 sable_ircd     #x1B[2m2026-08-30T22:12:06.250576Z#x1B[0m #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(882024911990689794)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] })
1788127926.251 sable_ircd     #x1B[2m2026-08-30T22:12:06.250587Z#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(882024911990689794)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] }
1788127926.251 S -> 1: :My.Little.Server 001 coolNick :Welcome to the test Internet Relay Chat network, coolNick
1788127926.251 S -> 1: :My.Little.Server 002 coolNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127926.351 1 -> S: PING synchronize572.472517873
1788127926.351 S -> 1: :My.Little.Server 003 coolNick :This server was created 2026-08-30 22:12:06.250478608 UTC
1788127926.351 S -> 1: :My.Little.Server 004 coolNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127926.351 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
1788127926.351 S -> 1: :My.Little.Server 422 coolNick :MOTD File is missing
1788127926.351 S -> 1: :coolNick!myusernam@localhost MODE coolNick +
1788127926.351 S -> 1: :My.Little.Server NOTICE coolNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127926.352 sable_ircd     #x1B[2m2026-08-30T22:12:06.351455Z#x1B[0m #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
1788127926.352 sable_ircd     #x1B[2m2026-08-30T22:12:06.351520Z#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 synchronize572.472517873"
1788127926.352 sable_ircd     #x1B[2m2026-08-30T22:12:06.351651Z#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 :synchronize572.472517873
1788127926.352 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize572.472517873
1788127926.352 1 -> S: JOIN #chan
1788127926.352 sable_ircd     #x1B[2m2026-08-30T22:12:06.352129Z#x1B[0m #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
1788127926.352 sable_ircd     #x1B[2m2026-08-30T22:12:06.352165Z#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"
1788127926.352 sable_ircd     #x1B[2m2026-08-30T22:12:06.352404Z#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(882024912422703107)), timestamp: 1788127926, clock: EventClock(1 => 882024911990689794), target: Channel(ChannelId(Snowflake(882024912422703106))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 882024911990689794) my clock=EventClock(1 => 882024911990689794)
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.352555Z#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
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.352600Z#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(882024912422703108)), timestamp: 1788127926, clock: EventClock(1 => 882024912422703107), target: Membership(MembershipId(UserId(Snowflake(882024911990689792)), ChannelId(Snowflake(882024912422703106)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024912422703106)), user: UserId(Snowflake(882024911990689792)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 882024912422703107) my clock=EventClock(1 => 882024912422703107)
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.352682Z#x1B[0m #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
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.352722Z#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
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.352861Z#x1B[0m #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(882024912422703107)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] })
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.352888Z#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(882024912422703107)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] }
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.352935Z#x1B[0m #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(882024912422703108)), timestamp: 1788127926, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024911990689792)), ChannelId(Snowflake(882024912422703106))), user: HistoricUserId(UserId(Snowflake(882024911990689792)), 2) }), users_to_notify: [UserId(Snowflake(882024911990689792))] })
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.352957Z#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(882024912422703108)), timestamp: 1788127926, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024911990689792)), ChannelId(Snowflake(882024912422703106))), user: HistoricUserId(UserId(Snowflake(882024911990689792)), 2) }), users_to_notify: [UserId(Snowflake(882024911990689792))] }
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.353014Z#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
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.353045Z#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
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.353085Z#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
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.353103Z#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
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.353136Z#x1B[0m #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(882024912422703108)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] })
1788127926.353 sable_ircd     #x1B[2m2026-08-30T22:12:06.353153Z#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(882024912422703108)), timestamp: 1788127926, change: EventComplete(EventComplete), users_to_notify: [] }
1788127926.452 1 -> S: PING synchronize572.57368576
1788127926.452 S -> 1: :coolNick!myusernam@localhost JOIN #chan
1788127926.452 S -> 1: :coolNick!myusernam@localhost MODE #chan +o coolNick
1788127926.452 S -> 1: :My.Little.Server 353 coolNick = #chan :@coolNick
1788127926.452 S -> 1: :My.Little.Server 366 coolNick #chan :End of names list
1788127926.453 sable_ircd     #x1B[2m2026-08-30T22:12:06.452569Z#x1B[0m #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
1788127926.453 sable_ircd     #x1B[2m2026-08-30T22:12:06.452621Z#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 synchronize572.57368576"
1788127927.205 sable_ircd     #x1B[2m2026-08-30T22:12:07.205252Z#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 :synchronize572.57368576
1788127927.206 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize572.57368576
1788127927.206 2: connects to server.
1788127927.206 2 -> S: NICK otherNick
1788127927.206 2 -> S: USER username * * :Realname
1788127927.206 sable_ircd     #x1B[2m2026-08-30T22:12:07.205999Z#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 }
1788127927.206 sable_ircd     #x1B[2m2026-08-30T22:12:07.206072Z#x1B[0m #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
1788127927.206 sable_ircd     #x1B[2m2026-08-30T22:12:07.206096Z#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
1788127927.206 sable_ircd     #x1B[2m2026-08-30T22:12:07.206141Z#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
1788127927.206 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname
1788127927.206 sable_ircd     #x1B[2m2026-08-30T22:12:07.206237Z#x1B[0m #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
1788127927.206 sable_ircd     #x1B[2m2026-08-30T22:12:07.206271Z#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"
1788127927.206 sable_ircd     #x1B[2m2026-08-30T22:12:07.206374Z#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: 573, tv_nsec: 327747896 }, 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
1788127927.206 sable_ircd     #x1B[2m2026-08-30T22:12:07.206436Z#x1B[0m #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
1788127927.206 sable_ircd     #x1B[2m2026-08-30T22:12:07.206461Z#x1B[0m #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
1788127927.207 sable_ircd     #x1B[2m2026-08-30T22:12:07.206493Z#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"
1788127927.207 sable_ircd     #x1B[2m2026-08-30T22:12:07.206555Z#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: 573, tv_nsec: 327747896 }, 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
1788127927.207 sable_ircd     #x1B[2m2026-08-30T22:12:07.207049Z#x1B[0m #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
1788127927.207 sable_ircd     #x1B[2m2026-08-30T22:12:07.207072Z#x1B[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"))
1788127927.207 sable_ircd     #x1B[2m2026-08-30T22:12:07.207091Z#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
1788127927.207 sable_ircd     #x1B[2m2026-08-30T22:12:07.207106Z#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: 573, tv_nsec: 327747896 }, 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
1788127927.207 sable_ircd     #x1B[2m2026-08-30T22:12:07.207134Z#x1B[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))
1788127927.207 sable_ircd     #x1B[2m2026-08-30T22:12:07.207316Z#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(882024916008833029)), timestamp: 1788127927, clock: EventClock(1 => 882024912422703108), target: User(UserId(Snowflake(882024916008833027))), 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(882024916008833028)), NewUserConnection { user: UserId(Snowflake(882024916008833027)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127927 })) }) }; event clock=EventClock(1 => 882024912422703108) my clock=EventClock(1 => 882024912422703108)
1788127927.207 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127927.207 sable_ircd     #x1B[2m2026-08-30T22:12:07.207423Z#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
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207637Z#x1B[0m #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(882024916008833029)), timestamp: 1788127927, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024916008833027)), 1) }), users_to_notify: [] })
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207666Z#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(882024916008833029)), timestamp: 1788127927, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024916008833027)), 1) }), users_to_notify: [] }
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207703Z#x1B[0m #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(882024916008833029)), timestamp: 1788127927, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024916008833027)), 2), connection: UserConnectionId(Snowflake(882024916008833028)) }), users_to_notify: [] })
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207721Z#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(882024916008833029)), timestamp: 1788127927, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024916008833027)), 2), connection: UserConnectionId(Snowflake(882024916008833028)) }), users_to_notify: [] }
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207766Z#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
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207789Z#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
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207815Z#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:07.207805771 UTC
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207833Z#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
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207859Z#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
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207877Z#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
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207901Z#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 +
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207919Z#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.
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207947Z#x1B[0m #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(882024916008833029)), timestamp: 1788127927, change: EventComplete(EventComplete), users_to_notify: [] })
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.207963Z#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(882024916008833029)), timestamp: 1788127927, change: EventComplete(EventComplete), users_to_notify: [] }
1788127927.208 S -> 2: :My.Little.Server 001 otherNick :Welcome to the test Internet Relay Chat network, otherNick
1788127927.208 2 -> S: PING foo
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.208338Z#x1B[0m #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
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.208374Z#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"
1788127927.208 sable_ircd     #x1B[2m2026-08-30T22:12:07.208452Z#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
1788127927.308 2 -> S: PING synchronize573.429939645
1788127927.308 S -> 2: :My.Little.Server 002 otherNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127927.308 S -> 2: :My.Little.Server 003 otherNick :This server was created 2026-08-30 22:12:07.207805771 UTC
1788127927.309 S -> 2: :My.Little.Server 004 otherNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127927.309 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
1788127927.309 S -> 2: :My.Little.Server 422 otherNick :MOTD File is missing
1788127927.309 S -> 2: :otherNick!username@localhost MODE otherNick +
1788127927.309 S -> 2: :My.Little.Server NOTICE otherNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127927.309 S -> 2: :My.Little.Server PONG My.Little.Server :foo
1788127927.309 sable_ircd     #x1B[2m2026-08-30T22:12:07.308873Z#x1B[0m #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
1788127927.309 sable_ircd     #x1B[2m2026-08-30T22:12:07.308938Z#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 synchronize573.429939645"
1788127927.309 sable_ircd     #x1B[2m2026-08-30T22:12:07.309075Z#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 :synchronize573.429939645
1788127927.309 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize573.429939645
1788127928.110 2 -> S: PING synchronize574.231912201
1788127928.111 sable_ircd     #x1B[2m2026-08-30T22:12:08.110810Z#x1B[0m #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
1788127928.111 sable_ircd     #x1B[2m2026-08-30T22:12:08.110876Z#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 synchronize574.231912201"
1788127928.111 sable_ircd     #x1B[2m2026-08-30T22:12:08.111007Z#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 :synchronize574.231912201
1788127928.111 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize574.231912201
1788127928.111 2 -> S: JOIN #chan
1788127928.111 sable_ircd     #x1B[2m2026-08-30T22:12:08.111452Z#x1B[0m #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
1788127928.112 sable_ircd     #x1B[2m2026-08-30T22:12:08.111488Z#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"
1788127928.211 2 -> S: PING synchronize574.333023716
1788127928.212 sable_ircd     #x1B[2m2026-08-30T22:12:08.211793Z#x1B[0m #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
1788127928.212 sable_ircd     #x1B[2m2026-08-30T22:12:08.211847Z#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 synchronize574.333023716"
1788127929.213 2: waiting…
1788127929.216 sable_ircd     #x1B[2m2026-08-30T22:12:09.216292Z#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(882024924435189766)), timestamp: 1788127929, clock: EventClock(1 => 882024916008833029), target: Membership(MembershipId(UserId(Snowflake(882024916008833027)), ChannelId(Snowflake(882024912422703106)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024912422703106)), user: UserId(Snowflake(882024916008833027)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882024916008833029) my clock=EventClock(1 => 882024916008833029)
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216468Z#x1B[0m #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
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216475Z#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
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216689Z#x1B[0m #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(882024924435189766)), timestamp: 1788127929, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024916008833027)), ChannelId(Snowflake(882024912422703106))), user: HistoricUserId(UserId(Snowflake(882024916008833027)), 2) }), users_to_notify: [UserId(Snowflake(882024916008833027)), UserId(Snowflake(882024911990689792))] })
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216716Z#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(882024924435189766)), timestamp: 1788127929, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024916008833027)), ChannelId(Snowflake(882024912422703106))), user: HistoricUserId(UserId(Snowflake(882024916008833027)), 2) }), users_to_notify: [UserId(Snowflake(882024916008833027)), UserId(Snowflake(882024911990689792))] }
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216766Z#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
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216804Z#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
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216816Z#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
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216830Z#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
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216855Z#x1B[0m #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(882024924435189766)), timestamp: 1788127929, change: EventComplete(EventComplete), users_to_notify: [] })
1788127929.217 sable_ircd     #x1B[2m2026-08-30T22:12:09.216868Z#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(882024924435189766)), timestamp: 1788127929, change: EventComplete(EventComplete), users_to_notify: [] }
1788127929.217 S -> 2: :otherNick!username@localhost JOIN #chan
1788127929.257 S -> 2: :My.Little.Server 353 otherNick = #chan :otherNick @coolNick
1788127929.258 S -> 2: :My.Little.Server 366 otherNick #chan :End of names list
1788127930.221 sable_ircd     #x1B[2m2026-08-30T22:12:10.221225Z#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 :synchronize574.333023716
1788127930.222 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize574.333023716
1788127930.222 1 -> S: AWAY :be right back
1788127930.222 sable_ircd     #x1B[2m2026-08-30T22:12:10.221959Z#x1B[0m #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.222 sable_ircd     #x1B[2m2026-08-30T22:12:10.222001Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"AWAY :be right back"
1788127930.222 sable_ircd     #x1B[2m2026-08-30T22:12:10.222201Z#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(882024928654659591)), timestamp: 1788127930, clock: EventClock(1 => 882024924435189766), target: User(UserId(Snowflake(882024911990689792))), details: UserAway(UserAway { reason: Some(AwayReason("be right back")) }) }; event clock=EventClock(1 => 882024924435189766) my clock=EventClock(1 => 882024924435189766)
1788127930.222 sable_ircd     #x1B[2m2026-08-30T22:12:10.222324Z#x1B[0m #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.222 sable_ircd     #x1B[2m2026-08-30T22:12:10.222327Z#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.223 sable_ircd     #x1B[2m2026-08-30T22:12:10.222544Z#x1B[0m #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(882024928654659591)), timestamp: 1788127930, change: UserAwayChange(UserAwayChange { user: HistoricUserId(UserId(Snowflake(882024911990689792)), 3), old_reason: None, new_reason: Some(AwayReason("be right back")) }), users_to_notify: [UserId(Snowflake(882024916008833027)), UserId(Snowflake(882024911990689792))] })
1788127930.223 sable_ircd     #x1B[2m2026-08-30T22:12:10.222572Z#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(882024928654659591)), timestamp: 1788127930, change: UserAwayChange(UserAwayChange { user: HistoricUserId(UserId(Snowflake(882024911990689792)), 3), old_reason: None, new_reason: Some(AwayReason("be right back")) }), users_to_notify: [UserId(Snowflake(882024916008833027)), UserId(Snowflake(882024911990689792))] }
1788127930.223 sable_ircd     #x1B[2m2026-08-30T22:12:10.222617Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 306 coolNick :You have been marked as being away
1788127930.223 sable_ircd     #x1B[2m2026-08-30T22:12:10.222650Z#x1B[0m #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(882024928654659591)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] })
1788127930.223 sable_ircd     #x1B[2m2026-08-30T22:12:10.222662Z#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(882024928654659591)), timestamp: 1788127930, change: EventComplete(EventComplete), users_to_notify: [] }
1788127930.322 1 -> S: PING synchronize576.443465802
1788127930.322 S -> 1: :otherNick!username@localhost JOIN #chan
1788127930.322 S -> 1: :My.Little.Server 306 coolNick :You have been marked as being away
1788127930.322 sable_ircd     #x1B[2m2026-08-30T22:12:10.322346Z#x1B[0m #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.322 sable_ircd     #x1B[2m2026-08-30T22:12:10.322420Z#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.443465802"
1788127930.323 sable_ircd     #x1B[2m2026-08-30T22:12:10.322534Z#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.443465802
1788127930.323 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize576.443465802
1788127930.423 2 -> S: PING synchronize576.544495996
1788127930.423 sable_ircd     #x1B[2m2026-08-30T22:12:10.423312Z#x1B[0m #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.423 sable_ircd     #x1B[2m2026-08-30T22:12:10.423366Z#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 synchronize576.544495996"
1788127931.176 sable_ircd     #x1B[2m2026-08-30T22:12:11.176049Z#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 :synchronize576.544495996
1788127931.176 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize576.544495996
1788127931.176 2 -> S: WHO coolNick
1788127931.177 sable_ircd     #x1B[2m2026-08-30T22:12:11.176656Z#x1B[0m #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.177 sable_ircd     #x1B[2m2026-08-30T22:12:11.176689Z#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"
1788127931.277 2 -> S: PING synchronize577.398193635
1788127931.277 sable_ircd     #x1B[2m2026-08-30T22:12:11.276943Z#x1B[0m #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.277 sable_ircd     #x1B[2m2026-08-30T22:12:11.276985Z#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 synchronize577.398193635"
1788127932.031 sable_ircd     #x1B[2m2026-08-30T22:12:12.030678Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 352 otherNick * myusernam localhost * coolNick G :0 My UniqueReal Name
1788127932.031 sable_ircd     #x1B[2m2026-08-30T22:12:12.030719Z#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
1788127932.031 S -> 2: :My.Little.Server 352 otherNick * myusernam localhost * coolNick G :0 My UniqueReal Name
1788127932.071 S -> 2: :My.Little.Server 315 otherNick coolNick :End of /WHO list
1788127932.328 sable_ircd     #x1B[2m2026-08-30T22:12:12.327696Z#x1B[0m #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.328 sable_ircd     #x1B[2m2026-08-30T22:12:12.328011Z#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(882024937483669512)), timestamp: 1788127932, clock: EventClock(1 => 882024685825429511), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127932 }) }; event clock=EventClock(1 => 882024685825429511) my clock=EventClock(1 => 882024685825429511)
1788127932.328 sable_ircd     #x1B[2m2026-08-30T22:12:12.328076Z#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.328 sable_ircd     #x1B[2m2026-08-30T22:12:12.328212Z#x1B[0m #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(882024937483669512)), timestamp: 1788127932, change: EventComplete(EventComplete), users_to_notify: [] })
1788127932.328 sable_ircd     #x1B[2m2026-08-30T22:12:12.328236Z#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(882024937483669512)), timestamp: 1788127932, change: EventComplete(EventComplete), users_to_notify: [] }
1788127933.035 sable_ircd     #x1B[2m2026-08-30T22:12:13.035036Z#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 :synchronize577.398193635
1788127933.035 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize577.398193635
1788127933.038 1: disconnects from server.
1788127933.038 2: disconnects from server.