--------------------------------- Captured Out ---------------------------------
---- new test ----
1788127796.026 sable_ircd     uid=1001
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.029772Z#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(882024365808422912)), timestamp: 1788127796, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127796, name: ServerName("My.Little.Server"), ts: 1788127796, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.029877Z#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
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.029948Z#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
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.030022Z#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(882024365808422912)), timestamp: 1788127796, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127796, name: ServerName("My.Little.Server"), ts: 1788127796, 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
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.030114Z#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(882024365812617217)), timestamp: 1788127796, clock: EventClock(1 => 882024365808422912), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127796 }) }; event clock=EventClock(1 => 882024365808422912) my clock=EventClock(1 => 882024365808422912)
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.030141Z#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
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.030133Z#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(882024365808422912)), timestamp: 1788127796, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.030157Z#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(882024365808422912)), timestamp: 1788127796, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.030198Z#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(882024365808422912)), timestamp: 1788127796, change: EventComplete(EventComplete), users_to_notify: [] })
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.030218Z#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(882024365808422912)), timestamp: 1788127796, change: EventComplete(EventComplete), users_to_notify: [] }
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.030248Z#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(882024365812617217)), timestamp: 1788127796, change: EventComplete(EventComplete), users_to_notify: [] })
1788127796.030 sable_ircd     #x1B[2m2026-08-30T22:09:56.030265Z#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(882024365812617217)), timestamp: 1788127796, change: EventComplete(EventComplete), users_to_notify: [] }
1788127796.123 sable_ircd     #x1B[2m2026-08-30T22:09:56.122895Z#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 }
1788127796.123 sable_ircd     #x1B[2m2026-08-30T22:09:56.123028Z#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
1788127796.123 sable_ircd     #x1B[2m2026-08-30T22:09:56.123067Z#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
1788127796.123 sable_ircd     #x1B[2m2026-08-30T22:09:56.123133Z#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
1788127796.123 sable_ircd     #x1B[2m2026-08-30T22:09:56.123282Z#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
1788127796.123 sable_ircd     #x1B[2m2026-08-30T22:09:56.123329Z#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"
1788127796.123 sable_ircd     #x1B[2m2026-08-30T22:09:56.123445Z#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
1788127796.124 sable_ircd     #x1B[2m2026-08-30T22:09:56.123533Z#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))
1788127796.124 sable_ircd     #x1B[2m2026-08-30T22:09:56.123559Z#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)
1788127796.124 sable_ircd     #x1B[2m2026-08-30T22:09:56.123960Z#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
1788127796.124 sable_ircd     #x1B[2m2026-08-30T22:09:56.124024Z#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
1788127796.124 sable_ircd     #x1B[2m2026-08-30T22:09:56.124149Z#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
1788127796.144 1: connects to server.
1788127796.144 1 -> S: NICK nick
1788127796.144 1 -> S: USER username * * :Realname
1788127796.144 sable_ircd     #x1B[2m2026-08-30T22:09:56.144068Z#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 }
1788127796.144 sable_ircd     #x1B[2m2026-08-30T22:09:56.144178Z#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
1788127796.144 sable_ircd     #x1B[2m2026-08-30T22:09:56.144212Z#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
1788127796.144 sable_ircd     #x1B[2m2026-08-30T22:09:56.144267Z#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
1788127796.144 sable_ircd     #x1B[2m2026-08-30T22:09:56.144358Z#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
1788127796.144 sable_ircd     #x1B[2m2026-08-30T22:09:56.144407Z#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"
1788127796.145 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.144530Z#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: 442, tv_nsec: 265870565 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("nick")), 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
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.144588Z#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
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.144607Z#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
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.144626Z#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"
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.144674Z#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: 442, tv_nsec: 265870565 }, 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
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.145067Z#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
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.145095Z#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"))
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.145119Z#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
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.145134Z#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: 442, tv_nsec: 265870565 }, 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
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.145164Z#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))
1788127796.145 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127796.145 sable_ircd     #x1B[2m2026-08-30T22:09:56.145393Z#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(882024366294962178)), timestamp: 1788127796, clock: EventClock(1 => 882024365812617217), target: User(UserId(Snowflake(882024366294962176))), 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(882024366294962177)), NewUserConnection { user: UserId(Snowflake(882024366294962176)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127796 })) }) }; event clock=EventClock(1 => 882024365812617217) my clock=EventClock(1 => 882024365812617217)
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145485Z#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
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145715Z#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(882024366294962178)), timestamp: 1788127796, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024366294962176)), 1) }), users_to_notify: [] })
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145745Z#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(882024366294962178)), timestamp: 1788127796, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024366294962176)), 1) }), users_to_notify: [] }
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145780Z#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(882024366294962178)), timestamp: 1788127796, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024366294962176)), 2), connection: UserConnectionId(Snowflake(882024366294962177)) }), users_to_notify: [] })
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145793Z#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(882024366294962178)), timestamp: 1788127796, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024366294962176)), 2), connection: UserConnectionId(Snowflake(882024366294962177)) }), users_to_notify: [] }
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145829Z#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
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145844Z#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
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145860Z#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-30 22:09:56.145853288 UTC
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145870Z#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
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145893Z#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
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145905Z#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
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145921Z#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 +
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145931Z#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.
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145950Z#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(882024366294962178)), timestamp: 1788127796, change: EventComplete(EventComplete), users_to_notify: [] })
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.145962Z#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(882024366294962178)), timestamp: 1788127796, change: EventComplete(EventComplete), users_to_notify: [] }
1788127796.146 S -> 1: :My.Little.Server 001 nick :Welcome to the test Internet Relay Chat network, nick
1788127796.146 S -> 1: :My.Little.Server 002 nick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127796.146 S -> 1: :My.Little.Server 003 nick :This server was created 2026-08-30 22:09:56.145853288 UTC
1788127796.146 S -> 1: :My.Little.Server 004 nick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127796.146 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
1788127796.146 S -> 1: :My.Little.Server 422 nick :MOTD File is missing
1788127796.146 S -> 1: :nick!username@localhost MODE nick +
1788127796.146 S -> 1: :My.Little.Server NOTICE nick :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127796.146 1 -> S: PING foo
1788127796.146 sable_ircd     #x1B[2m2026-08-30T22:09:56.146474Z#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
1788127796.147 sable_ircd     #x1B[2m2026-08-30T22:09:56.146502Z#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"
1788127796.147 sable_ircd     #x1B[2m2026-08-30T22:09:56.146552Z#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
1788127796.509 sable_history  #x1B[2m2027-08-30T23:07:51.009541Z#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(1014310511870943298)), timestamp: 1819667271, clock: EventClock(1 => 1014295401760559126, 50 => 1014310260212703297, 99 => 1014295404927660036), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667271 }) }; event clock=EventClock(1 => 1014295401760559126, 50 => 1014310260212703297, 99 => 1014295404927660036) my clock=EventClock(1 => 1014295401760559126, 50 => 1014310260212703297, 99 => 1014295404927660036)
1788127796.509 sable_history  #x1B[2m2027-08-30T23:07:51.011101Z#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
1788127796.899 sable_history  #x1B[2m2027-08-30T22:57:35.382785Z#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(1014307929748348983)), timestamp: 1819666655, clock: EventClock(1 => 1014295842380582945, 50 => 1014307678090108982, 99 => 1014295842997547013), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666655 }) }; event clock=EventClock(1 => 1014295842380582945, 50 => 1014307678090108982, 99 => 1014295842997547013) my clock=EventClock(1 => 1014295842380582945, 50 => 1014307678090108982, 99 => 1014295842997547013)
1788127796.899 sable_history  #x1B[2m2027-08-30T22:57:35.384216Z#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
1788127796.947 1 -> S: PING synchronize443.068799049
1788127796.947 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1788127796.948 sable_ircd     #x1B[2m2026-08-30T22:09:56.947729Z#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
1788127796.948 sable_ircd     #x1B[2m2026-08-30T22:09:56.947789Z#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 synchronize443.068799049"
1788127796.948 sable_ircd     #x1B[2m2026-08-30T22:09:56.947912Z#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 :synchronize443.068799049
1788127796.948 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize443.068799049
1788127796.948 1 -> S: LINKS
1788127796.948 sable_ircd     #x1B[2m2026-08-30T22:09:56.948330Z#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
1788127796.948 sable_ircd     #x1B[2m2026-08-30T22:09:56.948358Z#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"LINKS"
1788127797.048 1 -> S: PING synchronize443.169910202
1788127797.049 sable_ircd     #x1B[2m2026-08-30T22:09:57.048813Z#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
1788127797.049 sable_ircd     #x1B[2m2026-08-30T22:09:57.048871Z#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 synchronize443.169910202"
1788127797.049 sable_ircd     #x1B[2m2026-08-30T22:09:57.048991Z#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 364 nick My.Little.Server My.Little.Server :0 last_ping=1788127796, version=sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127797.049 sable_ircd     #x1B[2m2026-08-30T22:09:57.049010Z#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 365 nick * :End of /LINKS list
1788127797.049 S -> 1: :My.Little.Server 364 nick My.Little.Server My.Little.Server :0 last_ping=1788127796, version=sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127797.089 S -> 1: :My.Little.Server 365 nick * :End of /LINKS list
1788127797.126 sable_history  #x1B[2m2027-08-30T23:10:40.339541Z#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(1014311222092439621)), timestamp: 1819667440, clock: EventClock(1 => 1014295353727389718, 50 => 1014310970438393924, 99 => 1014295356898684932), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667440 }) }; event clock=EventClock(1 => 1014295353727389718, 50 => 1014310970438393924, 99 => 1014295356898684932) my clock=EventClock(1 => 1014295353727389718, 50 => 1014310970438393924, 99 => 1014295356898684932)
1788127797.126 sable_history  #x1B[2m2027-08-30T23:10:40.340945Z#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
1788127797.137 sable_history  #x1B[2m2027-08-30T22:54:47.716056Z#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(1014307226501980211)), timestamp: 1819666487, clock: EventClock(1 => 1014295135892017153, 50 => 1014306974843740210), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666487 }) }; event clock=EventClock(1 => 1014295135892017153, 50 => 1014306974843740210) my clock=EventClock(1 => 1014295135892017153, 50 => 1014306974843740210)
1788127797.137 sable_history  #x1B[2m2027-08-30T22:54:47.717279Z#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
1788127797.637 sable_history  #x1B[2m2027-08-30T23:13:46.047586Z#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(1014312001008246856)), timestamp: 1819667626, clock: EventClock(1 => 1014295552021499922, 50 => 1014311749350006855, 99 => 1014295555868078086), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667626 }) }; event clock=EventClock(1 => 1014295552021499922, 50 => 1014311749350006855, 99 => 1014295555868078086) my clock=EventClock(1 => 1014295552021499922, 50 => 1014311749350006855, 99 => 1014295555868078086)
1788127797.637 sable_history  #x1B[2m2027-08-30T23:13:46.049005Z#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
1788127797.756 sable_history  #x1B[2m2027-08-30T22:54:48.191770Z#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(1014307228494274611)), timestamp: 1819666488, clock: EventClock(1 => 1014295138538622977, 50 => 1014306976831840306), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666488 }) }; event clock=EventClock(1 => 1014295138538622977, 50 => 1014306976831840306) my clock=EventClock(1 => 1014295138538622977, 50 => 1014306976831840306)
1788127797.756 sable_history  #x1B[2m2027-08-30T22:54:48.193412Z#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
1788127797.964 sable_history  #x1B[2m2027-08-30T23:00:24.671035Z#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(1014308639793684538)), timestamp: 1819666824, clock: EventClock(1 => 1014295541992919062, 50 => 1014308388135444537, 99 => 1014295545160019972), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666824 }) }; event clock=EventClock(1 => 1014295541992919062, 50 => 1014308388135444537, 99 => 1014295545160019972) my clock=EventClock(1 => 1014295541992919062, 50 => 1014308388135444537, 99 => 1014295545160019972)
1788127797.964 sable_history  #x1B[2m2027-08-30T23:00:24.672488Z#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
1788127798.053 sable_ircd     #x1B[2m2026-08-30T22:09:58.053252Z#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 :synchronize443.169910202
1788127798.054 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize443.169910202
1788127798.056 1: disconnects from server.