--------------------------------- Captured Out ---------------------------------
---- new test ----
1786476508.112 sable_ircd     uid=1001
1786476508.116 sable_ircd     #x1B[2m2026-08-11T19:28:28.115708Z#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(875098362305581056)), timestamp: 1786476508, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476508, name: ServerName("My.Little.Server"), ts: 1786476508, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1786476508.116 sable_ircd     #x1B[2m2026-08-11T19:28:28.115846Z#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
1786476508.116 sable_ircd     #x1B[2m2026-08-11T19:28:28.116097Z#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(875098362305581056)), timestamp: 1786476508, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476508, name: ServerName("My.Little.Server"), ts: 1786476508, 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
1786476508.116 sable_ircd     #x1B[2m2026-08-11T19:28:28.116296Z#x1B[0m #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(875098362305581056)), timestamp: 1786476508, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1786476508.116 sable_ircd     #x1B[2m2026-08-11T19:28:28.116350Z#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(875098362305581056)), timestamp: 1786476508, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1786476508.116 sable_ircd     #x1B[2m2026-08-11T19:28:28.116411Z#x1B[0m #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(875098362305581056)), timestamp: 1786476508, change: EventComplete(EventComplete), users_to_notify: [] })
1786476508.116 sable_ircd     #x1B[2m2026-08-11T19:28:28.116449Z#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(875098362305581056)), timestamp: 1786476508, change: EventComplete(EventComplete), users_to_notify: [] }
1786476508.117 sable_ircd     #x1B[2m2026-08-11T19:28:28.116678Z#x1B[0m #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
1786476508.117 sable_ircd     #x1B[2m2026-08-11T19:28:28.116966Z#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(875098362309775361)), timestamp: 1786476508, clock: EventClock(1 => 875098362305581056), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1786476508 }) }; event clock=EventClock(1 => 875098362305581056) my clock=EventClock(1 => 875098362305581056)
1786476508.117 sable_ircd     #x1B[2m2026-08-11T19:28:28.117022Z#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
1786476508.117 sable_ircd     #x1B[2m2026-08-11T19:28:28.117239Z#x1B[0m #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(875098362309775361)), timestamp: 1786476508, change: EventComplete(EventComplete), users_to_notify: [] })
1786476508.117 sable_ircd     #x1B[2m2026-08-11T19:28:28.117264Z#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(875098362309775361)), timestamp: 1786476508, change: EventComplete(EventComplete), users_to_notify: [] }
1786476508.208 sable_ircd     #x1B[2m2026-08-11T19:28:28.207995Z#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 }
1786476508.208 sable_ircd     #x1B[2m2026-08-11T19:28:28.208180Z#x1B[0m #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
1786476508.208 sable_ircd     #x1B[2m2026-08-11T19:28:28.208255Z#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
1786476508.208 sable_ircd     #x1B[2m2026-08-11T19:28:28.208336Z#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
1786476508.209 sable_ircd     #x1B[2m2026-08-11T19:28:28.208533Z#x1B[0m #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
1786476508.209 sable_ircd     #x1B[2m2026-08-11T19:28:28.208614Z#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"
1786476508.209 sable_ircd     #x1B[2m2026-08-11T19:28:28.208729Z#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
1786476508.209 sable_ircd     #x1B[2m2026-08-11T19:28:28.208838Z#x1B[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))
1786476508.209 sable_ircd     #x1B[2m2026-08-11T19:28:28.208878Z#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)
1786476508.210 sable_ircd     #x1B[2m2026-08-11T19:28:28.209577Z#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
1786476508.210 sable_ircd     #x1B[2m2026-08-11T19:28:28.209672Z#x1B[0m #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
1786476508.210 sable_ircd     #x1B[2m2026-08-11T19:28:28.209883Z#x1B[0m #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
1786476508.229 1: connects to server.
1786476508.229 1 -> S: NICK nick
1786476508.229 1 -> S: USER username * * :Realname
1786476508.229 sable_ircd     #x1B[2m2026-08-11T19:28:28.229434Z#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 }
1786476508.230 sable_ircd     #x1B[2m2026-08-11T19:28:28.229606Z#x1B[0m #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
1786476508.230 sable_ircd     #x1B[2m2026-08-11T19:28:28.229661Z#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
1786476508.230 sable_ircd     #x1B[2m2026-08-11T19:28:28.229734Z#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
1786476508.230 sable_ircd     #x1B[2m2026-08-11T19:28:28.229934Z#x1B[0m #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
1786476508.230 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1786476508.230 sable_ircd     #x1B[2m2026-08-11T19:28:28.229986Z#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 nick"
1786476508.230 sable_ircd     #x1B[2m2026-08-11T19:28:28.230130Z#x1B[0m #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
1786476508.230 sable_ircd     #x1B[2m2026-08-11T19:28:28.230184Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER username * * :Realname"
1786476508.230 sable_ircd     #x1B[2m2026-08-11T19:28:28.230293Z#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: 285, tv_nsec: 290212136 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(<uninit>), 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
1786476508.230 sable_ircd     #x1B[2m2026-08-11T19:28:28.230396Z#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: 285, tv_nsec: 290212136 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick")), 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
1786476508.231 sable_ircd     #x1B[2m2026-08-11T19:28:28.230477Z#x1B[0m #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
1786476508.231 sable_ircd     #x1B[2m2026-08-11T19:28:28.231154Z#x1B[0m #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
1786476508.231 sable_ircd     #x1B[2m2026-08-11T19:28:28.231204Z#x1B[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"))
1786476508.231 sable_ircd     #x1B[2m2026-08-11T19:28:28.231254Z#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
1786476508.231 sable_ircd     #x1B[2m2026-08-11T19:28:28.231296Z#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: 285, tv_nsec: 290212136 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick")), 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
1786476508.231 sable_ircd     #x1B[2m2026-08-11T19:28:28.231366Z#x1B[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))
1786476508.232 sable_ircd     #x1B[2m2026-08-11T19:28:28.231651Z#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(875098362792120322)), timestamp: 1786476508, clock: EventClock(1 => 875098362309775361), target: User(UserId(Snowflake(875098362792120320))), details: NewUser(NewUser { nickname: Nickname("nick"), 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(875098362792120321)), NewUserConnection { user: UserId(Snowflake(875098362792120320)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1786476508 })) }) }; event clock=EventClock(1 => 875098362309775361) my clock=EventClock(1 => 875098362309775361)
1786476508.232 sable_ircd     #x1B[2m2026-08-11T19:28:28.231755Z#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
1786476508.232 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232154Z#x1B[0m #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(875098362792120322)), timestamp: 1786476508, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098362792120320)), 1) }), users_to_notify: [] })
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232194Z#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(875098362792120322)), timestamp: 1786476508, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098362792120320)), 1) }), users_to_notify: [] }
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232258Z#x1B[0m #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(875098362792120322)), timestamp: 1786476508, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098362792120320)), 2), connection: UserConnectionId(Snowflake(875098362792120321)) }), users_to_notify: [] })
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232284Z#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(875098362792120322)), timestamp: 1786476508, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098362792120320)), 2), connection: UserConnectionId(Snowflake(875098362792120321)) }), users_to_notify: [] }
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232344Z#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 nick :Welcome to the test Internet Relay Chat network, nick
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232373Z#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 nick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232401Z#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 nick :This server was created 2026-08-11 19:28:28.232388758 UTC
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232426Z#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 nick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232475Z#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 nick 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
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232531Z#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 nick :MOTD File is missing
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232563Z#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): :nick!username@localhost MODE nick +
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232581Z#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 nick :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232626Z#x1B[0m #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(875098362792120322)), timestamp: 1786476508, change: EventComplete(EventComplete), users_to_notify: [] })
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.232649Z#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(875098362792120322)), timestamp: 1786476508, change: EventComplete(EventComplete), users_to_notify: [] }
1786476508.233 S -> 1: :My.Little.Server 001 nick :Welcome to the test Internet Relay Chat network, nick
1786476508.233 S -> 1: :My.Little.Server 002 nick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476508.233 1 -> S: PING foo
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.233183Z#x1B[0m #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
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.233222Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING foo"
1786476508.233 sable_ircd     #x1B[2m2026-08-11T19:28:28.233300Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :foo
1786476508.433 1 -> S: PING synchronize285.493708009
1786476508.433 S -> 1: :My.Little.Server 003 nick :This server was created 2026-08-11 19:28:28.232388758 UTC
1786476508.433 S -> 1: :My.Little.Server 004 nick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476508.433 S -> 1: :My.Little.Server 005 nick 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
1786476508.433 S -> 1: :My.Little.Server 422 nick :MOTD File is missing
1786476508.433 S -> 1: :nick!username@localhost MODE nick +
1786476508.433 S -> 1: :My.Little.Server NOTICE nick :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476508.433 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1786476508.434 sable_ircd     #x1B[2m2026-08-11T19:28:28.433742Z#x1B[0m #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
1786476508.434 sable_ircd     #x1B[2m2026-08-11T19:28:28.433818Z#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 synchronize285.493708009"
1786476508.434 sable_ircd     #x1B[2m2026-08-11T19:28:28.433984Z#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 :synchronize285.493708009
1786476508.434 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize285.493708009
1786476508.560 sable_history  #x1B[2m2027-08-11T20:03:03.442711Z#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(1007378637797924904)), timestamp: 1818014583, clock: EventClock(1 => 1007369314333888513, 50 => 1007378386139684903), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014583 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007378386139684903) my clock=EventClock(1 => 1007369314333888513, 50 => 1007378386139684903)
1786476508.560 sable_history  #x1B[2m2027-08-11T20:03:03.444988Z#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
1786476508.876 sable_history  #x1B[2m2027-08-11T20:08:39.717812Z#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(1007380048241696815)), timestamp: 1818014919, clock: EventClock(1 => 1007369718299889686, 50 => 1007379796579262510, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014919 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007379796579262510, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007379796579262510, 99 => 1007369721508933636)
1786476508.876 sable_history  #x1B[2m2027-08-11T20:08:39.719526Z#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
1786476509.035 1 -> S: HELP
1786476509.036 sable_ircd     #x1B[2m2026-08-11T19:28:29.035968Z#x1B[0m #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
1786476509.036 sable_ircd     #x1B[2m2026-08-11T19:28:29.036040Z#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"HELP"
1786476509.036 sable_ircd     #x1B[2m2026-08-11T19:28:29.036188Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 421 nick HELP :Unknown command
1786476509.041 sable_history  #x1B[2m2027-08-11T20:03:03.812450Z#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(1007378639349817384)), timestamp: 1818014583, clock: EventClock(1 => 1007369316242296833, 50 => 1007378387683188775), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014583 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007378387683188775) my clock=EventClock(1 => 1007369316242296833, 50 => 1007378387683188775)
1786476509.041 sable_history  #x1B[2m2027-08-11T20:03:03.814755Z#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
1786476509.136 1 -> S: PING synchronize286.196058402
1786476509.136 S -> 1: :My.Little.Server 421 nick HELP :Unknown command
1786476509.136 sable_ircd     #x1B[2m2026-08-11T19:28:29.136227Z#x1B[0m #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
1786476509.136 sable_ircd     #x1B[2m2026-08-11T19:28:29.136297Z#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 synchronize286.196058402"
1786476509.536 sable_history  #x1B[2m2027-08-11T20:11:28.354154Z#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(1007380755552346162)), timestamp: 1818015088, clock: EventClock(1 => 1007369670753259542, 50 => 1007380503894106161, 99 => 1007369673970692100), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015088 }) }; event clock=EventClock(1 => 1007369670753259542, 50 => 1007380503894106161, 99 => 1007369673970692100) my clock=EventClock(1 => 1007369670753259542, 50 => 1007380503894106161, 99 => 1007369673970692100)
1786476509.536 sable_history  #x1B[2m2027-08-11T20:11:28.355834Z#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
1786476509.549 sable_history  #x1B[2m2027-08-11T20:03:04.566216Z#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(1007378642512322600)), timestamp: 1818014584, clock: EventClock(1 => 1007369318356226049, 50 => 1007378390854082599), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014584 }) }; event clock=EventClock(1 => 1007369318356226049, 50 => 1007378390854082599) my clock=EventClock(1 => 1007369318356226049, 50 => 1007378390854082599)
1786476509.549 sable_history  #x1B[2m2027-08-11T20:03:04.567818Z#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
1786476510.059 sable_history  #x1B[2m2027-08-11T20:03:05.941894Z#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(1007378648283684905)), timestamp: 1818014585, clock: EventClock(1 => 1007369320184942593, 50 => 1007378396617056296, 99 => 1007369323750502402), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014585 }) }; event clock=EventClock(1 => 1007369320184942593, 50 => 1007378396617056296, 99 => 1007369323750502402) my clock=EventClock(1 => 1007369320184942593, 50 => 1007378396617056296, 99 => 1007369323750502402)
1786476510.059 sable_history  #x1B[2m2027-08-11T20:03:05.943615Z#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
1786476510.137 1: waiting…
1786476510.141 sable_ircd     #x1B[2m2026-08-11T19:28:30.140867Z#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 :synchronize286.196058402
1786476510.141 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize286.196058402
1786476510.146 1: disconnects from server.