--------------------------------- Captured Out ---------------------------------
---- new test ----
1773599958.161 sable_ircd     uid=1001
1773599958.166 sable_ircd     #x1B[2m2026-03-15T18:39:18.165003Z#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(821090197339901952)), timestamp: 1773599958, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1773599958, name: ServerName("My.Little.Server"), ts: 1773599958, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1773599958.166 sable_ircd     #x1B[2m2026-03-15T18:39:18.165138Z#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
1773599958.166 sable_ircd     #x1B[2m2026-03-15T18:39:18.165328Z#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(821090197339901952)), timestamp: 1773599958, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1773599958, name: ServerName("My.Little.Server"), ts: 1773599958, 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
1773599958.166 sable_ircd     #x1B[2m2026-03-15T18:39:18.165567Z#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(821090197339901952)), timestamp: 1773599958, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1773599958.166 sable_ircd     #x1B[2m2026-03-15T18:39:18.165609Z#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(821090197339901952)), timestamp: 1773599958, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1773599958.166 sable_ircd     #x1B[2m2026-03-15T18:39:18.165648Z#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(821090197339901952)), timestamp: 1773599958, change: EventComplete(EventComplete), users_to_notify: [] })
1773599958.166 sable_ircd     #x1B[2m2026-03-15T18:39:18.165670Z#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(821090197339901952)), timestamp: 1773599958, change: EventComplete(EventComplete), users_to_notify: [] }
1773599958.166 sable_ircd     #x1B[2m2026-03-15T18:39:18.166249Z#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
1773599958.167 sable_ircd     #x1B[2m2026-03-15T18:39:18.166428Z#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(821090197348290561)), timestamp: 1773599958, clock: EventClock(1 => 821090197339901952), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1773599958 }) }; event clock=EventClock(1 => 821090197339901952) my clock=EventClock(1 => 821090197339901952)
1773599958.167 sable_ircd     #x1B[2m2026-03-15T18:39:18.166504Z#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
1773599958.167 sable_ircd     #x1B[2m2026-03-15T18:39:18.166764Z#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(821090197348290561)), timestamp: 1773599958, change: EventComplete(EventComplete), users_to_notify: [] })
1773599958.167 sable_ircd     #x1B[2m2026-03-15T18:39:18.166800Z#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(821090197348290561)), timestamp: 1773599958, change: EventComplete(EventComplete), users_to_notify: [] }
1773599958.257 sable_ircd     #x1B[2m2026-03-15T18:39:18.256950Z#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 }
1773599958.257 sable_ircd     #x1B[2m2026-03-15T18:39:18.257121Z#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
1773599958.257 sable_ircd     #x1B[2m2026-03-15T18:39:18.257188Z#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
1773599958.257 sable_ircd     #x1B[2m2026-03-15T18:39:18.257260Z#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
1773599958.258 sable_ircd     #x1B[2m2026-03-15T18:39:18.257457Z#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
1773599958.258 sable_ircd     #x1B[2m2026-03-15T18:39:18.257529Z#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"
1773599958.258 sable_ircd     #x1B[2m2026-03-15T18:39:18.257687Z#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
1773599958.258 sable_ircd     #x1B[2m2026-03-15T18:39:18.257795Z#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))
1773599958.258 sable_ircd     #x1B[2m2026-03-15T18:39:18.257831Z#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)
1773599958.258 sable_ircd     #x1B[2m2026-03-15T18:39:18.258294Z#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
1773599958.258 sable_ircd     #x1B[2m2026-03-15T18:39:18.258363Z#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
1773599958.259 sable_ircd     #x1B[2m2026-03-15T18:39:18.258568Z#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
1773599958.278 1: connects to server.
1773599958.278 1 -> S: NICK chanop
1773599958.278 1 -> S: USER username * * :Realname
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.278477Z#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 }
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.278631Z#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
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.278673Z#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
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.278741Z#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
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.278908Z#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
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.278965Z#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 chanop"
1773599958.279 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.279150Z#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: 409, tv_nsec: 958177823 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("chanop")), 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
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.279227Z#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
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.279285Z#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
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.279317Z#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"
1773599958.279 sable_ircd     #x1B[2m2026-03-15T18:39:18.279391Z#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: 409, tv_nsec: 958177823 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("chanop")), 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
1773599958.280 sable_ircd     #x1B[2m2026-03-15T18:39:18.279988Z#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
1773599958.280 sable_ircd     #x1B[2m2026-03-15T18:39:18.280034Z#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"))
1773599958.280 sable_ircd     #x1B[2m2026-03-15T18:39:18.280065Z#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
1773599958.280 sable_ircd     #x1B[2m2026-03-15T18:39:18.280088Z#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: 409, tv_nsec: 958177823 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("chanop")), 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
1773599958.280 sable_ircd     #x1B[2m2026-03-15T18:39:18.280135Z#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))
1773599958.281 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.280431Z#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(821090197826441218)), timestamp: 1773599958, clock: EventClock(1 => 821090197348290561), target: User(UserId(Snowflake(821090197826441216))), details: NewUser(NewUser { nickname: Nickname("chanop"), 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(821090197826441217)), NewUserConnection { user: UserId(Snowflake(821090197826441216)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773599958 })) }) }; event clock=EventClock(1 => 821090197348290561) my clock=EventClock(1 => 821090197348290561)
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.280572Z#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
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.280879Z#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(821090197826441218)), timestamp: 1773599958, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(821090197826441216)), 1) }), users_to_notify: [] })
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.280923Z#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(821090197826441218)), timestamp: 1773599958, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(821090197826441216)), 1) }), users_to_notify: [] }
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.280976Z#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(821090197826441218)), timestamp: 1773599958, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(821090197826441216)), 2), connection: UserConnectionId(Snowflake(821090197826441217)) }), users_to_notify: [] })
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281002Z#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(821090197826441218)), timestamp: 1773599958, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(821090197826441216)), 2), connection: UserConnectionId(Snowflake(821090197826441217)) }), users_to_notify: [] }
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281051Z#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 chanop :Welcome to the test Internet Relay Chat network, chanop
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281078Z#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 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281101Z#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 chanop :This server was created 2026-03-15 18:39:18.281093018 UTC
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281123Z#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 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281155Z#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 chanop 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
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281173Z#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 chanop :MOTD File is missing
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281194Z#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): :chanop!username@localhost MODE chanop +
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281210Z#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 chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281248Z#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(821090197826441218)), timestamp: 1773599958, change: EventComplete(EventComplete), users_to_notify: [] })
1773599958.281 sable_ircd     #x1B[2m2026-03-15T18:39:18.281270Z#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(821090197826441218)), timestamp: 1773599958, change: EventComplete(EventComplete), users_to_notify: [] }
1773599958.282 S -> 1: :My.Little.Server 001 chanop :Welcome to the test Internet Relay Chat network, chanop
1773599958.282 1 -> S: PING foo
1773599958.282 sable_ircd     #x1B[2m2026-03-15T18:39:18.281789Z#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
1773599958.282 sable_ircd     #x1B[2m2026-03-15T18:39:18.281838Z#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"
1773599958.282 sable_ircd     #x1B[2m2026-03-15T18:39:18.281938Z#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
1773599958.382 1 -> S: PING synchronize410.061187201
1773599958.382 S -> 1: :My.Little.Server 002 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1773599958.382 S -> 1: :My.Little.Server 003 chanop :This server was created 2026-03-15 18:39:18.281093018 UTC
1773599958.382 S -> 1: :My.Little.Server 004 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1773599958.382 S -> 1: :My.Little.Server 005 chanop 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
1773599958.382 S -> 1: :My.Little.Server 422 chanop :MOTD File is missing
1773599958.382 S -> 1: :chanop!username@localhost MODE chanop +
1773599958.382 S -> 1: :My.Little.Server NOTICE chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1773599958.382 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1773599958.382 sable_ircd     #x1B[2m2026-03-15T18:39:18.382349Z#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
1773599958.382 sable_ircd     #x1B[2m2026-03-15T18:39:18.382435Z#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 synchronize410.061187201"
1773599958.383 sable_ircd     #x1B[2m2026-03-15T18:39:18.382642Z#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 :synchronize410.061187201
1773599958.383 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize410.061187201
1773599959.084 1 -> S: JOIN #chan
1773599959.085 sable_ircd     #x1B[2m2026-03-15T18:39:19.084464Z#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
1773599959.085 sable_ircd     #x1B[2m2026-03-15T18:39:19.084526Z#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"
1773599959.085 sable_ircd     #x1B[2m2026-03-15T18:39:19.084851Z#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(821090201198661635)), timestamp: 1773599959, clock: EventClock(1 => 821090197826441218), target: Channel(ChannelId(Snowflake(821090201198661634))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 821090197826441218) my clock=EventClock(1 => 821090197826441218)
1773599959.085 sable_ircd     #x1B[2m2026-03-15T18:39:19.085025Z#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
1773599959.085 sable_ircd     #x1B[2m2026-03-15T18:39:19.085111Z#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(821090201202855940)), timestamp: 1773599959, clock: EventClock(1 => 821090201198661635), target: Membership(MembershipId(UserId(Snowflake(821090197826441216)), ChannelId(Snowflake(821090201198661634)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(821090201198661634)), user: UserId(Snowflake(821090197826441216)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 821090201198661635) my clock=EventClock(1 => 821090201198661635)
1773599959.085 sable_ircd     #x1B[2m2026-03-15T18:39:19.085235Z#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
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085345Z#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
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085386Z#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(821090201198661635)), timestamp: 1773599959, change: EventComplete(EventComplete), users_to_notify: [] })
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085425Z#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(821090201198661635)), timestamp: 1773599959, change: EventComplete(EventComplete), users_to_notify: [] }
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085602Z#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(821090201202855940)), timestamp: 1773599959, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(821090197826441216)), ChannelId(Snowflake(821090201198661634))), user: HistoricUserId(UserId(Snowflake(821090197826441216)), 2) }), users_to_notify: [UserId(Snowflake(821090197826441216))] })
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085641Z#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(821090201202855940)), timestamp: 1773599959, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(821090197826441216)), ChannelId(Snowflake(821090201198661634))), user: HistoricUserId(UserId(Snowflake(821090197826441216)), 2) }), users_to_notify: [UserId(Snowflake(821090197826441216))] }
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085719Z#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): :chanop!username@localhost JOIN #chan
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085774Z#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): :chanop!username@localhost MODE #chan +o chanop
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085842Z#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 chanop = #chan :@chanop
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085883Z#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 chanop #chan :End of names list
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085954Z#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(821090201202855940)), timestamp: 1773599959, change: EventComplete(EventComplete), users_to_notify: [] })
1773599959.086 sable_ircd     #x1B[2m2026-03-15T18:39:19.085986Z#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(821090201202855940)), timestamp: 1773599959, change: EventComplete(EventComplete), users_to_notify: [] }
1773599959.184 1 -> S: PING synchronize410.863560428
1773599959.184 S -> 1: :chanop!username@localhost JOIN #chan
1773599959.184 S -> 1: :chanop!username@localhost MODE #chan +o chanop
1773599959.184 S -> 1: :My.Little.Server 353 chanop = #chan :@chanop
1773599959.184 S -> 1: :My.Little.Server 366 chanop #chan :End of names list
1773599959.185 sable_ircd     #x1B[2m2026-03-15T18:39:19.184676Z#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
1773599959.185 sable_ircd     #x1B[2m2026-03-15T18:39:19.184751Z#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 synchronize410.863560428"
1773599960.185 1: waiting…
1773599960.190 sable_ircd     #x1B[2m2026-03-15T18:39:20.190390Z#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 :synchronize410.863560428
1773599960.191 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize410.863560428
1773599960.191 1 -> S: MODE #chan +k key
1773599960.191 sable_ircd     #x1B[2m2026-03-15T18:39:20.191146Z#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
1773599960.191 sable_ircd     #x1B[2m2026-03-15T18:39:20.191196Z#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"MODE #chan +k key"
1773599960.291 1 -> S: PING synchronize411.970444003
1773599960.292 sable_ircd     #x1B[2m2026-03-15T18:39:20.291489Z#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
1773599960.292 sable_ircd     #x1B[2m2026-03-15T18:39:20.291594Z#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 synchronize411.970444003"
1773599961.045 sable_ircd     #x1B[2m2026-03-15T18:39:21.045219Z#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(821090209423691781)), timestamp: 1773599961, clock: EventClock(1 => 821090201202855940), target: Channel(ChannelId(Snowflake(821090201198661634))), details: ChannelModeChange(ChannelModeChange { changed_by: User(UserId(Snowflake(821090197826441216))), added: ChannelModeSet(0), removed: ChannelModeSet(0), key_change: Set(ChannelKey("key")) }) }; event clock=EventClock(1 => 821090201202855940) my clock=EventClock(1 => 821090201202855940)
1773599961.045 sable_ircd     #x1B[2m2026-03-15T18:39:21.045432Z#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
1773599961.046 sable_ircd     #x1B[2m2026-03-15T18:39:21.045440Z#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
1773599961.046 sable_ircd     #x1B[2m2026-03-15T18:39:21.045782Z#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(821090209423691781)), timestamp: 1773599961, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(821090201198661634)), added: ChannelModeSet(0), removed: ChannelModeSet(0), key_change: Set(ChannelKey("key")), changed_by: User(HistoricUserId(UserId(Snowflake(821090197826441216)), 2)) }), users_to_notify: [UserId(Snowflake(821090197826441216))] })
1773599961.046 sable_ircd     #x1B[2m2026-03-15T18:39:21.045835Z#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(821090209423691781)), timestamp: 1773599961, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(821090201198661634)), added: ChannelModeSet(0), removed: ChannelModeSet(0), key_change: Set(ChannelKey("key")), changed_by: User(HistoricUserId(UserId(Snowflake(821090197826441216)), 2)) }), users_to_notify: [UserId(Snowflake(821090197826441216))] }
1773599961.046 sable_ircd     #x1B[2m2026-03-15T18:39:21.045930Z#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): :chanop!username@localhost MODE #chan +k key
1773599961.046 sable_ircd     #x1B[2m2026-03-15T18:39:21.046019Z#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(821090209423691781)), timestamp: 1773599961, change: EventComplete(EventComplete), users_to_notify: [] })
1773599961.046 sable_ircd     #x1B[2m2026-03-15T18:39:21.046058Z#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(821090209423691781)), timestamp: 1773599961, change: EventComplete(EventComplete), users_to_notify: [] }
1773599961.046 S -> 1: :chanop!username@localhost MODE #chan +k key
1773599962.048 1: waiting…
1773599962.052 sable_ircd     #x1B[2m2026-03-15T18:39:22.051935Z#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 :synchronize411.970444003
1773599962.052 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize411.970444003
1773599962.053 2: connects to server.
1773599962.053 2 -> S: NICK joiner
1773599962.053 2 -> S: USER username * * :Realname
1773599962.053 sable_ircd     #x1B[2m2026-03-15T18:39:22.053092Z#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 }
1773599962.053 sable_ircd     #x1B[2m2026-03-15T18:39:22.053200Z#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
1773599962.053 sable_ircd     #x1B[2m2026-03-15T18:39:22.053245Z#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
1773599962.053 sable_ircd     #x1B[2m2026-03-15T18:39:22.053298Z#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
1773599962.053 sable_ircd     #x1B[2m2026-03-15T18:39:22.053419Z#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
1773599962.054 sable_ircd     #x1B[2m2026-03-15T18:39:22.053484Z#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 joiner"
1773599962.054 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname
1773599962.054 sable_ircd     #x1B[2m2026-03-15T18:39:22.053667Z#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: 413, tv_nsec: 732745473 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("joiner")), 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
1773599962.054 sable_ircd     #x1B[2m2026-03-15T18:39:22.053733Z#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
1773599962.054 sable_ircd     #x1B[2m2026-03-15T18:39:22.053788Z#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
1773599962.054 sable_ircd     #x1B[2m2026-03-15T18:39:22.053835Z#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"
1773599962.054 sable_ircd     #x1B[2m2026-03-15T18:39:22.053925Z#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: 413, tv_nsec: 732745473 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("joiner")), 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
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.054480Z#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
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.054515Z#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"))
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.054566Z#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
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.054596Z#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: 413, tv_nsec: 732745473 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("joiner")), 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
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.054637Z#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))
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.054850Z#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(821090213655744518)), timestamp: 1773599962, clock: EventClock(1 => 821090209423691781), target: User(UserId(Snowflake(821090213655744515))), details: NewUser(NewUser { nickname: Nickname("joiner"), 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(821090213655744516)), NewUserConnection { user: UserId(Snowflake(821090213655744515)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1773599962 })) }) }; event clock=EventClock(1 => 821090209423691781) my clock=EventClock(1 => 821090209423691781)
1773599962.055 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.054961Z#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
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.055233Z#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(821090213655744518)), timestamp: 1773599962, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(821090213655744515)), 1) }), users_to_notify: [] })
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.055273Z#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(821090213655744518)), timestamp: 1773599962, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(821090213655744515)), 1) }), users_to_notify: [] }
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.055326Z#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(821090213655744518)), timestamp: 1773599962, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(821090213655744515)), 2), connection: UserConnectionId(Snowflake(821090213655744516)) }), users_to_notify: [] })
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.055352Z#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(821090213655744518)), timestamp: 1773599962, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(821090213655744515)), 2), connection: UserConnectionId(Snowflake(821090213655744516)) }), users_to_notify: [] }
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.055396Z#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 joiner :Welcome to the test Internet Relay Chat network, joiner
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.055423Z#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 joiner :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.055442Z#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 joiner :This server was created 2026-03-15 18:39:22.055435334 UTC
1773599962.055 sable_ircd     #x1B[2m2026-03-15T18:39:22.055461Z#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 joiner My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1773599962.056 sable_ircd     #x1B[2m2026-03-15T18:39:22.055482Z#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 joiner 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
1773599962.056 sable_ircd     #x1B[2m2026-03-15T18:39:22.055501Z#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 joiner :MOTD File is missing
1773599962.056 sable_ircd     #x1B[2m2026-03-15T18:39:22.055518Z#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): :joiner!username@localhost MODE joiner +
1773599962.056 sable_ircd     #x1B[2m2026-03-15T18:39:22.055558Z#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 joiner :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1773599962.056 sable_ircd     #x1B[2m2026-03-15T18:39:22.055602Z#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(821090213655744518)), timestamp: 1773599962, change: EventComplete(EventComplete), users_to_notify: [] })
1773599962.056 sable_ircd     #x1B[2m2026-03-15T18:39:22.055631Z#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(821090213655744518)), timestamp: 1773599962, change: EventComplete(EventComplete), users_to_notify: [] }
1773599962.056 S -> 2: :My.Little.Server 001 joiner :Welcome to the test Internet Relay Chat network, joiner
1773599962.056 2 -> S: PING foo
1773599962.056 sable_ircd     #x1B[2m2026-03-15T18:39:22.056126Z#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
1773599962.056 sable_ircd     #x1B[2m2026-03-15T18:39:22.056174Z#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"
1773599962.056 sable_ircd     #x1B[2m2026-03-15T18:39:22.056271Z#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
1773599962.156 2 -> S: PING synchronize413.835520817
1773599962.156 S -> 2: :My.Little.Server 002 joiner :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1773599962.156 S -> 2: :My.Little.Server 003 joiner :This server was created 2026-03-15 18:39:22.055435334 UTC
1773599962.156 S -> 2: :My.Little.Server 004 joiner My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1773599962.156 S -> 2: :My.Little.Server 005 joiner 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
1773599962.156 S -> 2: :My.Little.Server 422 joiner :MOTD File is missing
1773599962.156 S -> 2: :joiner!username@localhost MODE joiner +
1773599962.156 S -> 2: :My.Little.Server NOTICE joiner :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1773599962.156 S -> 2: :My.Little.Server PONG My.Little.Server :foo
1773599962.157 sable_ircd     #x1B[2m2026-03-15T18:39:22.156738Z#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
1773599962.157 sable_ircd     #x1B[2m2026-03-15T18:39:22.156812Z#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 synchronize413.835520817"
1773599962.157 sable_ircd     #x1B[2m2026-03-15T18:39:22.156951Z#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 :synchronize413.835520817
1773599962.157 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize413.835520817
1773599962.858 2 -> S: JOIN #chan key
1773599962.859 sable_ircd     #x1B[2m2026-03-15T18:39:22.858910Z#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
1773599962.859 sable_ircd     #x1B[2m2026-03-15T18:39:22.858977Z#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 key"
1773599962.959 2 -> S: PING synchronize414.638051995
1773599962.959 sable_ircd     #x1B[2m2026-03-15T18:39:22.959311Z#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
1773599962.959 sable_ircd     #x1B[2m2026-03-15T18:39:22.959436Z#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 synchronize414.638051995"
1773599963.210 sable_ircd     #x1B[2m2026-03-15T18:39:23.210399Z#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(821090218504359943)), timestamp: 1773599963, clock: EventClock(1 => 821090213655744518), target: Membership(MembershipId(UserId(Snowflake(821090213655744515)), ChannelId(Snowflake(821090201198661634)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(821090201198661634)), user: UserId(Snowflake(821090213655744515)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 821090213655744518) my clock=EventClock(1 => 821090213655744518)
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.210580Z#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
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.210600Z#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
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.210886Z#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(821090218504359943)), timestamp: 1773599963, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(821090213655744515)), ChannelId(Snowflake(821090201198661634))), user: HistoricUserId(UserId(Snowflake(821090213655744515)), 2) }), users_to_notify: [UserId(Snowflake(821090197826441216)), UserId(Snowflake(821090213655744515))] })
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.210937Z#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(821090218504359943)), timestamp: 1773599963, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(821090213655744515)), ChannelId(Snowflake(821090201198661634))), user: HistoricUserId(UserId(Snowflake(821090213655744515)), 2) }), users_to_notify: [UserId(Snowflake(821090197826441216)), UserId(Snowflake(821090213655744515))] }
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.211030Z#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): :joiner!username@localhost JOIN #chan
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.211148Z#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): :joiner!username@localhost JOIN #chan
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.211236Z#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 joiner = #chan :@chanop joiner
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.211287Z#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 joiner #chan :End of names list
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.211352Z#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(821090218504359943)), timestamp: 1773599963, change: EventComplete(EventComplete), users_to_notify: [] })
1773599963.211 sable_ircd     #x1B[2m2026-03-15T18:39:23.211384Z#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(821090218504359943)), timestamp: 1773599963, change: EventComplete(EventComplete), users_to_notify: [] }
1773599963.212 S -> 2: :joiner!username@localhost JOIN #chan
1773599963.212 S -> 2: :My.Little.Server 353 joiner = #chan :@chanop joiner
1773599963.212 S -> 2: :My.Little.Server 366 joiner #chan :End of names list
1773599964.213 2: waiting…
1773599964.216 sable_ircd     #x1B[2m2026-03-15T18:39:24.215982Z#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 :synchronize414.638051995
1773599964.216 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize414.638051995
1773599964.219 1: disconnects from server.
1773599964.219 2: disconnects from server.