--------------------------------- Captured Out --------------------------------- ---- new test ---- 1788127976.031 sable_ircd uid=1001 1788127976.035 sable_ircd #x1B[2m2026-08-30T22:12:56.034177Z#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(882025120804114432)), timestamp: 1788127976, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127976, name: ServerName("My.Little.Server"), ts: 1788127976, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1788127976.035 sable_ircd #x1B[2m2026-08-30T22:12:56.034265Z#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 1788127976.035 sable_ircd #x1B[2m2026-08-30T22:12:56.034377Z#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(882025120804114432)), timestamp: 1788127976, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127976, name: ServerName("My.Little.Server"), ts: 1788127976, 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 1788127976.035 sable_ircd #x1B[2m2026-08-30T22:12:56.034498Z#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(882025120804114432)), timestamp: 1788127976, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1788127976.035 sable_ircd #x1B[2m2026-08-30T22:12:56.034517Z#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(882025120804114432)), timestamp: 1788127976, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1788127976.035 sable_ircd #x1B[2m2026-08-30T22:12:56.034539Z#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(882025120804114432)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127976.035 sable_ircd #x1B[2m2026-08-30T22:12:56.034548Z#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(882025120804114432)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] } 1788127976.036 sable_ircd #x1B[2m2026-08-30T22:12:56.035982Z#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 1788127976.036 sable_ircd #x1B[2m2026-08-30T22:12:56.036063Z#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(882025120812503041)), timestamp: 1788127976, clock: EventClock(1 => 882025120804114432), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127976 }) }; event clock=EventClock(1 => 882025120804114432) my clock=EventClock(1 => 882025120804114432) 1788127976.036 sable_ircd #x1B[2m2026-08-30T22:12:56.036103Z#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 1788127976.036 sable_ircd #x1B[2m2026-08-30T22:12:56.036228Z#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(882025120812503041)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127976.036 sable_ircd #x1B[2m2026-08-30T22:12:56.036250Z#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(882025120812503041)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] } 1788127976.128 sable_ircd #x1B[2m2026-08-30T22:12:56.127983Z#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 } 1788127976.128 sable_ircd #x1B[2m2026-08-30T22:12:56.128096Z#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 1788127976.128 sable_ircd #x1B[2m2026-08-30T22:12:56.128144Z#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 1788127976.128 sable_ircd #x1B[2m2026-08-30T22:12:56.128199Z#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 1788127976.128 sable_ircd #x1B[2m2026-08-30T22:12:56.128327Z#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 1788127976.128 sable_ircd #x1B[2m2026-08-30T22:12:56.128369Z#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" 1788127976.129 sable_ircd #x1B[2m2026-08-30T22:12:56.128473Z#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 1788127976.129 sable_ircd #x1B[2m2026-08-30T22:12:56.128553Z#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)) 1788127976.129 sable_ircd #x1B[2m2026-08-30T22:12:56.128579Z#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) 1788127976.129 sable_ircd #x1B[2m2026-08-30T22:12:56.128921Z#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 1788127976.129 sable_ircd #x1B[2m2026-08-30T22:12:56.128984Z#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 1788127976.129 sable_ircd #x1B[2m2026-08-30T22:12:56.129136Z#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 1788127976.149 1: connects to server. 1788127976.149 1 -> S: NICK coolNick 1788127976.149 1 -> S: USER myusernam 0 * :My UniqueReal Name 1788127976.149 sable_ircd #x1B[2m2026-08-30T22:12:56.148995Z#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 } 1788127976.149 sable_ircd #x1B[2m2026-08-30T22:12:56.149087Z#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 1788127976.149 sable_ircd #x1B[2m2026-08-30T22:12:56.149113Z#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 1788127976.149 sable_ircd #x1B[2m2026-08-30T22:12:56.149150Z#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 1788127976.149 sable_ircd #x1B[2m2026-08-30T22:12:56.149229Z#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 1788127976.149 sable_ircd #x1B[2m2026-08-30T22:12:56.149261Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK coolNick" 1788127976.149 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127976.149 sable_ircd #x1B[2m2026-08-30T22:12:56.149404Z#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: 622, tv_nsec: 270756655 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("coolNick")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127976.149 sable_ircd #x1B[2m2026-08-30T22:12:56.149471Z#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 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.149508Z#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 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.149537Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER myusernam 0 * :My UniqueReal Name" 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.149600Z#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: 622, tv_nsec: 270756655 }, attach_user_id: OnceLock(), user: OnceLock(Username("myusernam")), extra_user_params: OnceLock(("0", "*")), nick: OnceLock(Nickname("coolNick")), realname: OnceLock(Realname("My UniqueReal Name")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.149964Z#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 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.149991Z#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")) 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.150010Z#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 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.150024Z#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: 622, tv_nsec: 270756655 }, attach_user_id: OnceLock(), user: OnceLock(Username("myusernam")), extra_user_params: OnceLock(("0", "*")), nick: OnceLock(Nickname("coolNick")), realname: OnceLock(Realname("My UniqueReal Name")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.150058Z#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)) 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.150270Z#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(882025121290653698)), timestamp: 1788127976, clock: EventClock(1 => 882025120812503041), target: User(UserId(Snowflake(882025121290653696))), details: NewUser(NewUser { nickname: Nickname("coolNick"), username: Username("myusernam"), visible_hostname: Hostname("localhost"), realname: Realname("My UniqueReal Name"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(882025121290653697)), NewUserConnection { user: UserId(Snowflake(882025121290653696)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127976 })) }) }; event clock=EventClock(1 => 882025120812503041) my clock=EventClock(1 => 882025120812503041) 1788127976.150 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127976.150 sable_ircd #x1B[2m2026-08-30T22:12:56.150351Z#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 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150577Z#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(882025121290653698)), timestamp: 1788127976, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025121290653696)), 1) }), users_to_notify: [] }) 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150604Z#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(882025121290653698)), timestamp: 1788127976, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025121290653696)), 1) }), users_to_notify: [] } 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150640Z#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(882025121290653698)), timestamp: 1788127976, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025121290653696)), 2), connection: UserConnectionId(Snowflake(882025121290653697)) }), users_to_notify: [] }) 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150653Z#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(882025121290653698)), timestamp: 1788127976, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025121290653696)), 2), connection: UserConnectionId(Snowflake(882025121290653697)) }), users_to_notify: [] } 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150688Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 001 coolNick :Welcome to the test Internet Relay Chat network, coolNick 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150704Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 002 coolNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150719Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 003 coolNick :This server was created 2026-08-30 22:12:56.150713260 UTC 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150730Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 004 coolNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150752Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 005 coolNick EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150764Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 422 coolNick :MOTD File is missing 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150776Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :coolNick!myusernam@localhost MODE coolNick + 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150786Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE coolNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150809Z#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(882025121290653698)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127976.151 sable_ircd #x1B[2m2026-08-30T22:12:56.150821Z#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(882025121290653698)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] } 1788127976.151 S -> 1: :My.Little.Server 001 coolNick :Welcome to the test Internet Relay Chat network, coolNick 1788127976.251 1 -> S: PING synchronize622.372734112 1788127976.251 S -> 1: :My.Little.Server 002 coolNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127976.251 S -> 1: :My.Little.Server 003 coolNick :This server was created 2026-08-30 22:12:56.150713260 UTC 1788127976.251 S -> 1: :My.Little.Server 004 coolNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127976.251 S -> 1: :My.Little.Server 005 coolNick EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1788127976.251 S -> 1: :My.Little.Server 422 coolNick :MOTD File is missing 1788127976.251 S -> 1: :coolNick!myusernam@localhost MODE coolNick + 1788127976.251 S -> 1: :My.Little.Server NOTICE coolNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127976.252 sable_ircd #x1B[2m2026-08-30T22:12:56.251590Z#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 1788127976.252 sable_ircd #x1B[2m2026-08-30T22:12:56.251639Z#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 synchronize622.372734112" 1788127976.252 sable_ircd #x1B[2m2026-08-30T22:12:56.251734Z#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 :synchronize622.372734112 1788127976.252 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize622.372734112 1788127976.252 1 -> S: JOIN #chan 1788127976.252 sable_ircd #x1B[2m2026-08-30T22:12:56.252147Z#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 1788127976.252 sable_ircd #x1B[2m2026-08-30T22:12:56.252175Z#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" 1788127976.252 sable_ircd #x1B[2m2026-08-30T22:12:56.252335Z#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(882025121718472707)), timestamp: 1788127976, clock: EventClock(1 => 882025121290653698), target: Channel(ChannelId(Snowflake(882025121718472706))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 882025121290653698) my clock=EventClock(1 => 882025121290653698) 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252490Z#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 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252547Z#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(882025121718472708)), timestamp: 1788127976, clock: EventClock(1 => 882025121718472707), target: Membership(MembershipId(UserId(Snowflake(882025121290653696)), ChannelId(Snowflake(882025121718472706)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882025121718472706)), user: UserId(Snowflake(882025121290653696)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 882025121718472707) my clock=EventClock(1 => 882025121718472707) 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252626Z#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 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252685Z#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 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252733Z#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(882025121718472707)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252758Z#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(882025121718472707)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] } 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252857Z#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(882025121718472708)), timestamp: 1788127976, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025121290653696)), ChannelId(Snowflake(882025121718472706))), user: HistoricUserId(UserId(Snowflake(882025121290653696)), 2) }), users_to_notify: [UserId(Snowflake(882025121290653696))] }) 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252883Z#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(882025121718472708)), timestamp: 1788127976, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025121290653696)), ChannelId(Snowflake(882025121718472706))), user: HistoricUserId(UserId(Snowflake(882025121290653696)), 2) }), users_to_notify: [UserId(Snowflake(882025121290653696))] } 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252925Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :coolNick!myusernam@localhost JOIN #chan 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252947Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :coolNick!myusernam@localhost MODE #chan +o coolNick 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252972Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 353 coolNick = #chan :@coolNick 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.252983Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 366 coolNick #chan :End of names list 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.253011Z#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(882025121718472708)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127976.253 sable_ircd #x1B[2m2026-08-30T22:12:56.253023Z#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(882025121718472708)), timestamp: 1788127976, change: EventComplete(EventComplete), users_to_notify: [] } 1788127976.352 1 -> S: PING synchronize622.47372257 1788127976.352 S -> 1: :coolNick!myusernam@localhost JOIN #chan 1788127976.352 S -> 1: :coolNick!myusernam@localhost MODE #chan +o coolNick 1788127976.352 S -> 1: :My.Little.Server 353 coolNick = #chan :@coolNick 1788127976.352 S -> 1: :My.Little.Server 366 coolNick #chan :End of names list 1788127976.353 sable_ircd #x1B[2m2026-08-30T22:12:56.352533Z#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 1788127976.353 sable_ircd #x1B[2m2026-08-30T22:12:56.352580Z#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 synchronize622.47372257" 1788127976.509 sable_history #x1B[2m2027-08-30T23:52:51.009602Z#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(1014321836491743343)), timestamp: 1819669971, clock: EventClock(1 => 1014295401760559126, 50 => 1014321584833503342, 99 => 1014295404927660036), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669971 }) }; event clock=EventClock(1 => 1014295401760559126, 50 => 1014321584833503342, 99 => 1014295404927660036) my clock=EventClock(1 => 1014295401760559126, 50 => 1014321584833503342, 99 => 1014295404927660036) 1788127976.509 sable_history #x1B[2m2027-08-30T23:52:51.011160Z#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 1788127976.899 sable_history #x1B[2m2027-08-30T23:42:35.382986Z#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(1014319254369149028)), timestamp: 1819669355, clock: EventClock(1 => 1014295842380582945, 50 => 1014319002710909027, 99 => 1014295842997547013), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669355 }) }; event clock=EventClock(1 => 1014295842380582945, 50 => 1014319002710909027, 99 => 1014295842997547013) my clock=EventClock(1 => 1014295842380582945, 50 => 1014319002710909027, 99 => 1014295842997547013) 1788127976.899 sable_history #x1B[2m2027-08-30T23:42:35.384538Z#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 1788127977.106 sable_ircd #x1B[2m2026-08-30T22:12:57.106157Z#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 :synchronize622.47372257 1788127977.107 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize622.47372257 1788127977.107 2: connects to server. 1788127977.107 2 -> S: NICK otherNick 1788127977.107 2 -> S: USER username * * :Realname 1788127977.107 sable_ircd #x1B[2m2026-08-30T22:12:57.107068Z#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 } 1788127977.107 sable_ircd #x1B[2m2026-08-30T22:12:57.107169Z#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 1788127977.107 sable_ircd #x1B[2m2026-08-30T22:12:57.107207Z#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 1788127977.107 sable_ircd #x1B[2m2026-08-30T22:12:57.107261Z#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 1788127977.107 sable_ircd #x1B[2m2026-08-30T22:12:57.107377Z#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 1788127977.107 sable_ircd #x1B[2m2026-08-30T22:12:57.107431Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK otherNick" 1788127977.108 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.107536Z#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: 623, tv_nsec: 228866892 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("otherNick")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.107592Z#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 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.107634Z#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 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.107666Z#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" 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.107732Z#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: 623, tv_nsec: 228866892 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("otherNick")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.108240Z#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 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.108264Z#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")) 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.108284Z#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 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.108299Z#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: 623, tv_nsec: 228866892 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("otherNick")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127977.108 sable_ircd #x1B[2m2026-08-30T22:12:57.108328Z#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)) 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.108523Z#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(882025125308796933)), timestamp: 1788127977, clock: EventClock(1 => 882025121718472708), target: User(UserId(Snowflake(882025125308796931))), details: NewUser(NewUser { nickname: Nickname("otherNick"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(882025125308796932)), NewUserConnection { user: UserId(Snowflake(882025125308796931)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127977 })) }) }; event clock=EventClock(1 => 882025121718472708) my clock=EventClock(1 => 882025121718472708) 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.108612Z#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 1788127977.109 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.108850Z#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(882025125308796933)), timestamp: 1788127977, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025125308796931)), 1) }), users_to_notify: [] }) 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.108880Z#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(882025125308796933)), timestamp: 1788127977, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025125308796931)), 1) }), users_to_notify: [] } 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.108913Z#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(882025125308796933)), timestamp: 1788127977, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025125308796931)), 2), connection: UserConnectionId(Snowflake(882025125308796932)) }), users_to_notify: [] }) 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.108926Z#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(882025125308796933)), timestamp: 1788127977, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025125308796931)), 2), connection: UserConnectionId(Snowflake(882025125308796932)) }), users_to_notify: [] } 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.108962Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 001 otherNick :Welcome to the test Internet Relay Chat network, otherNick 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.108977Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 002 otherNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.108992Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 003 otherNick :This server was created 2026-08-30 22:12:57.108985996 UTC 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.109003Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 004 otherNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.109018Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 005 otherNick EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.109029Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 422 otherNick :MOTD File is missing 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.109042Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :otherNick!username@localhost MODE otherNick + 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.109052Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE otherNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.109067Z#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(882025125308796933)), timestamp: 1788127977, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127977.109 sable_ircd #x1B[2m2026-08-30T22:12:57.109079Z#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(882025125308796933)), timestamp: 1788127977, change: EventComplete(EventComplete), users_to_notify: [] } 1788127977.109 S -> 2: :My.Little.Server 001 otherNick :Welcome to the test Internet Relay Chat network, otherNick 1788127977.109 S -> 2: :My.Little.Server 002 otherNick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127977.109 S -> 2: :My.Little.Server 003 otherNick :This server was created 2026-08-30 22:12:57.108985996 UTC 1788127977.109 S -> 2: :My.Little.Server 004 otherNick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127977.109 S -> 2: :My.Little.Server 005 otherNick EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1788127977.109 S -> 2: :My.Little.Server 422 otherNick :MOTD File is missing 1788127977.109 S -> 2: :otherNick!username@localhost MODE otherNick + 1788127977.109 S -> 2: :My.Little.Server NOTICE otherNick :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127977.109 2 -> S: PING foo 1788127977.110 sable_ircd #x1B[2m2026-08-30T22:12:57.109624Z#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 1788127977.110 sable_ircd #x1B[2m2026-08-30T22:12:57.109661Z#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" 1788127977.110 sable_ircd #x1B[2m2026-08-30T22:12:57.109727Z#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 1788127977.126 sable_history #x1B[2m2027-08-30T23:55:40.340518Z#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(1014322546717433970)), timestamp: 1819670140, clock: EventClock(1 => 1014295353727389718, 50 => 1014322295054999665, 99 => 1014295356898684932), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819670140 }) }; event clock=EventClock(1 => 1014295353727389718, 50 => 1014322295054999665, 99 => 1014295356898684932) my clock=EventClock(1 => 1014295353727389718, 50 => 1014322295054999665, 99 => 1014295356898684932) 1788127977.126 sable_history #x1B[2m2027-08-30T23:55:40.342245Z#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 1788127977.137 sable_history #x1B[2m2027-08-30T23:39:47.716347Z#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(1014318551122780256)), timestamp: 1819669187, clock: EventClock(1 => 1014295135892017153, 50 => 1014318299468734559), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669187 }) }; event clock=EventClock(1 => 1014295135892017153, 50 => 1014318299468734559) my clock=EventClock(1 => 1014295135892017153, 50 => 1014318299468734559) 1788127977.137 sable_history #x1B[2m2027-08-30T23:39:47.717842Z#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 1788127977.637 sable_history #x1B[2m2027-08-30T23:58:46.047699Z#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(1014323325629046901)), timestamp: 1819670326, clock: EventClock(1 => 1014295552021499922, 50 => 1014323073975001204, 99 => 1014295555868078086), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819670326 }) }; event clock=EventClock(1 => 1014295552021499922, 50 => 1014323073975001204, 99 => 1014295555868078086) my clock=EventClock(1 => 1014295552021499922, 50 => 1014323073975001204, 99 => 1014295555868078086) 1788127977.637 sable_history #x1B[2m2027-08-30T23:58:46.049156Z#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 1788127977.756 sable_history #x1B[2m2027-08-30T23:39:48.190630Z#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(1014318553115074656)), timestamp: 1819669188, clock: EventClock(1 => 1014295138538622977, 50 => 1014318301456834655), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669188 }) }; event clock=EventClock(1 => 1014295138538622977, 50 => 1014318301456834655) my clock=EventClock(1 => 1014295138538622977, 50 => 1014318301456834655) 1788127977.756 sable_history #x1B[2m2027-08-30T23:39:48.192482Z#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 1788127977.910 2 -> S: PING synchronize624.031956016 1788127977.910 S -> 2: :My.Little.Server PONG My.Little.Server :foo 1788127977.911 sable_ircd #x1B[2m2026-08-30T22:12:57.910903Z#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 1788127977.911 sable_ircd #x1B[2m2026-08-30T22:12:57.910972Z#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 synchronize624.031956016" 1788127977.911 sable_ircd #x1B[2m2026-08-30T22:12:57.911114Z#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 :synchronize624.031956016 1788127977.911 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize624.031956016 1788127977.964 sable_history #x1B[2m2027-08-30T23:45:24.671091Z#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(1014319964414484583)), timestamp: 1819669524, clock: EventClock(1 => 1014295541992919062, 50 => 1014319712756244582, 99 => 1014295545160019972), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669524 }) }; event clock=EventClock(1 => 1014295541992919062, 50 => 1014319712756244582, 99 => 1014295545160019972) my clock=EventClock(1 => 1014295541992919062, 50 => 1014319712756244582, 99 => 1014295545160019972) 1788127977.964 sable_history #x1B[2m2027-08-30T23:45:24.672491Z#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 1788127978.012 2 -> S: PING synchronize624.133130037 1788127978.012 sable_ircd #x1B[2m2026-08-30T22:12:58.012056Z#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 1788127978.012 sable_ircd #x1B[2m2026-08-30T22:12:58.012118Z#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 synchronize624.133130037" 1788127978.012 sable_ircd #x1B[2m2026-08-30T22:12:58.012255Z#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 :synchronize624.133130037 1788127978.013 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize624.133130037 1788127978.013 2 -> S: JOIN #chan 1788127978.013 sable_ircd #x1B[2m2026-08-30T22:12:58.012772Z#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 1788127978.013 sable_ircd #x1B[2m2026-08-30T22:12:58.012809Z#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" 1788127978.113 2 -> S: PING synchronize624.234308664 1788127978.113 sable_ircd #x1B[2m2026-08-30T22:12:58.113095Z#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 1788127978.113 sable_ircd #x1B[2m2026-08-30T22:12:58.113148Z#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 synchronize624.234308664" 1788127978.313 sable_history #x1B[2m2027-08-30T23:39:48.943326Z#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(1014318556269191264)), timestamp: 1819669188, clock: EventClock(1 => 1014295140782575617, 50 => 1014318304606756959), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669188 }) }; event clock=EventClock(1 => 1014295140782575617, 50 => 1014318304606756959) my clock=EventClock(1 => 1014295140782575617, 50 => 1014318304606756959) 1788127978.313 sable_history #x1B[2m2027-08-30T23:39:48.945016Z#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 1788127978.700 sable_history #x1B[2m2027-08-30T23:48:14.293830Z#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(1014320675864911978)), timestamp: 1819669694, clock: EventClock(1 => 1014295494442094614, 50 => 1014320424206671977, 99 => 1014295497634361348), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669694 }) }; event clock=EventClock(1 => 1014295494442094614, 50 => 1014320424206671977, 99 => 1014295497634361348) my clock=EventClock(1 => 1014295494442094614, 50 => 1014320424206671977, 99 => 1014295497634361348) 1788127978.700 sable_history #x1B[2m2027-08-30T23:48:14.295304Z#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 1788127978.746 sable_history #x1B[2m2027-08-30T23:39:49.167589Z#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(1014318557208715360)), timestamp: 1819669189, clock: EventClock(1 => 1014295142766481409, 50 => 1014318305554669663), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669189 }) }; event clock=EventClock(1 => 1014295142766481409, 50 => 1014318305554669663) my clock=EventClock(1 => 1014295142766481409, 50 => 1014318305554669663) 1788127978.746 sable_history #x1B[2m2027-08-30T23:39:49.168977Z#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 1788127979.114 2: waiting… 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.117546Z#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(882025133735153670)), timestamp: 1788127979, clock: EventClock(1 => 882025125308796933), target: Membership(MembershipId(UserId(Snowflake(882025125308796931)), ChannelId(Snowflake(882025121718472706)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882025121718472706)), user: UserId(Snowflake(882025125308796931)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882025125308796933) my clock=EventClock(1 => 882025125308796933) 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.117675Z#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 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.117678Z#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 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.117887Z#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(882025133735153670)), timestamp: 1788127979, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025125308796931)), ChannelId(Snowflake(882025121718472706))), user: HistoricUserId(UserId(Snowflake(882025125308796931)), 2) }), users_to_notify: [UserId(Snowflake(882025125308796931)), UserId(Snowflake(882025121290653696))] }) 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.117917Z#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(882025133735153670)), timestamp: 1788127979, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025125308796931)), ChannelId(Snowflake(882025121718472706))), user: HistoricUserId(UserId(Snowflake(882025125308796931)), 2) }), users_to_notify: [UserId(Snowflake(882025125308796931)), UserId(Snowflake(882025121290653696))] } 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.117966Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :otherNick!username@localhost JOIN #chan 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.118002Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 353 otherNick = #chan :otherNick @coolNick 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.118015Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 366 otherNick #chan :End of names list 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.118028Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :otherNick!username@localhost JOIN #chan 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.118058Z#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(882025133735153670)), timestamp: 1788127979, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127979.118 sable_ircd #x1B[2m2026-08-30T22:12:59.118070Z#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(882025133735153670)), timestamp: 1788127979, change: EventComplete(EventComplete), users_to_notify: [] } 1788127979.118 S -> 2: :otherNick!username@localhost JOIN #chan 1788127979.128 sable_history #x1B[2m2027-08-30T23:39:49.547791Z#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(1014318558806745184)), timestamp: 1819669189, clock: EventClock(1 => 1014295144268042241, 50 => 1014318307148505183), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669189 }) }; event clock=EventClock(1 => 1014295144268042241, 50 => 1014318307148505183) my clock=EventClock(1 => 1014295144268042241, 50 => 1014318307148505183) 1788127979.128 sable_history #x1B[2m2027-08-30T23:39:49.549478Z#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 1788127979.158 S -> 2: :My.Little.Server 353 otherNick = #chan :otherNick @coolNick 1788127979.159 S -> 2: :My.Little.Server 366 otherNick #chan :End of names list 1788127979.632 sable_history #x1B[2m2027-08-30T23:51:02.100634Z#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(1014321379694289005)), timestamp: 1819669862, clock: EventClock(1 => 1014295448346693654, 50 => 1014321128036049004, 99 => 1014295451547348996), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669862 }) }; event clock=EventClock(1 => 1014295448346693654, 50 => 1014321128036049004, 99 => 1014295451547348996) my clock=EventClock(1 => 1014295448346693654, 50 => 1014321128036049004, 99 => 1014295451547348996) 1788127979.632 sable_history #x1B[2m2027-08-30T23:51:02.102059Z#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 1788127979.649 sable_history #x1B[2m2027-08-30T23:39:50.148063Z#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(1014318561323327585)), timestamp: 1819669190, clock: EventClock(1 => 1014295224354082831, 50 => 1014318309665087584, 99 => 1014295214413983748), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819669190 }) }; event clock=EventClock(1 => 1014295224354082831, 50 => 1014318309665087584, 99 => 1014295214413983748) my clock=EventClock(1 => 1014295224354082831, 50 => 1014318309665087584, 99 => 1014295214413983748) 1788127979.649 sable_history #x1B[2m2027-08-30T23:39:50.149188Z#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 1788127980.122 sable_ircd #x1B[2m2026-08-30T22:13:00.122349Z#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 :synchronize624.234308664 1788127980.123 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize624.234308664 1788127980.126 1: disconnects from server. 1788127980.126 2: disconnects from server.