--------------------------------- Captured Out --------------------------------- ---- new test ---- 1772747466.048 sable_ircd uid=1001 1772747466.052 sable_ircd #x1B[2m2026-03-05T21:51:06.051498Z#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(817514586260377600)), timestamp: 1772747466, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747466, name: ServerName("My.Little.Server"), ts: 1772747466, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1772747466.052 sable_ircd #x1B[2m2026-03-05T21:51:06.051646Z#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 1772747466.052 sable_ircd #x1B[2m2026-03-05T21:51:06.051888Z#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(817514586260377600)), timestamp: 1772747466, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747466, name: ServerName("My.Little.Server"), ts: 1772747466, 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 1772747466.052 sable_ircd #x1B[2m2026-03-05T21:51:06.052023Z#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(817514586260377600)), timestamp: 1772747466, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1772747466.052 sable_ircd #x1B[2m2026-03-05T21:51:06.052072Z#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(817514586260377600)), timestamp: 1772747466, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1772747466.052 sable_ircd #x1B[2m2026-03-05T21:51:06.052137Z#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(817514586260377600)), timestamp: 1772747466, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747466.052 sable_ircd #x1B[2m2026-03-05T21:51:06.052174Z#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(817514586260377600)), timestamp: 1772747466, change: EventComplete(EventComplete), users_to_notify: [] } 1772747466.053 sable_ircd #x1B[2m2026-03-05T21:51:06.052695Z#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 1772747466.053 sable_ircd #x1B[2m2026-03-05T21:51:06.052822Z#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(817514586264571905)), timestamp: 1772747466, clock: EventClock(1 => 817514586260377600), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1772747466 }) }; event clock=EventClock(1 => 817514586260377600) my clock=EventClock(1 => 817514586260377600) 1772747466.053 sable_ircd #x1B[2m2026-03-05T21:51:06.052896Z#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 1772747466.053 sable_ircd #x1B[2m2026-03-05T21:51:06.053156Z#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(817514586264571905)), timestamp: 1772747466, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747466.053 sable_ircd #x1B[2m2026-03-05T21:51:06.053198Z#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(817514586264571905)), timestamp: 1772747466, change: EventComplete(EventComplete), users_to_notify: [] } 1772747466.144 sable_ircd #x1B[2m2026-03-05T21:51:06.143832Z#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 } 1772747466.144 sable_ircd #x1B[2m2026-03-05T21:51:06.144009Z#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 1772747466.144 sable_ircd #x1B[2m2026-03-05T21:51:06.144055Z#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 1772747466.144 sable_ircd #x1B[2m2026-03-05T21:51:06.144126Z#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 1772747466.144 sable_ircd #x1B[2m2026-03-05T21:51:06.144292Z#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 1772747466.144 sable_ircd #x1B[2m2026-03-05T21:51:06.144379Z#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" 1772747466.145 sable_ircd #x1B[2m2026-03-05T21:51:06.144531Z#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 1772747466.145 sable_ircd #x1B[2m2026-03-05T21:51:06.144650Z#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)) 1772747466.145 sable_ircd #x1B[2m2026-03-05T21:51:06.144691Z#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) 1772747466.145 sable_ircd #x1B[2m2026-03-05T21:51:06.145168Z#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 1772747466.145 sable_ircd #x1B[2m2026-03-05T21:51:06.145265Z#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 1772747466.146 sable_ircd #x1B[2m2026-03-05T21:51:06.145516Z#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 1772747466.165 chanop: connects to server. 1772747466.165 chanop -> S: NICK chanop 1772747466.165 chanop -> S: USER username * * :Realname 1772747466.165 sable_ircd #x1B[2m2026-03-05T21:51:06.165253Z#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 } 1772747466.165 sable_ircd #x1B[2m2026-03-05T21:51:06.165434Z#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 1772747466.166 sable_ircd #x1B[2m2026-03-05T21:51:06.165495Z#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 1772747466.166 sable_ircd #x1B[2m2026-03-05T21:51:06.165572Z#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 1772747466.166 sable_ircd #x1B[2m2026-03-05T21:51:06.165730Z#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 1772747466.166 sable_ircd #x1B[2m2026-03-05T21:51:06.165786Z#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" 1772747466.166 S -> chanop: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747466.166 sable_ircd #x1B[2m2026-03-05T21:51:06.165920Z#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 1772747466.166 sable_ircd #x1B[2m2026-03-05T21:51:06.165978Z#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" 1772747466.166 sable_ircd #x1B[2m2026-03-05T21:51:06.166092Z#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: 303, tv_nsec: 502214389 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(), 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 1772747466.166 sable_ircd #x1B[2m2026-03-05T21:51:06.166197Z#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: 303, tv_nsec: 502214389 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("chanop")), 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 1772747466.166 sable_ircd #x1B[2m2026-03-05T21:51:06.166262Z#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 1772747466.167 sable_ircd #x1B[2m2026-03-05T21:51:06.166847Z#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 1772747466.167 sable_ircd #x1B[2m2026-03-05T21:51:06.166887Z#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")) 1772747466.167 sable_ircd #x1B[2m2026-03-05T21:51:06.166915Z#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 1772747466.167 sable_ircd #x1B[2m2026-03-05T21:51:06.166939Z#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: 303, tv_nsec: 502214389 }, attach_user_id: OnceLock(), 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(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747466.167 sable_ircd #x1B[2m2026-03-05T21:51:06.166992Z#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)) 1772747466.167 sable_ircd #x1B[2m2026-03-05T21:51:06.167298Z#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(817514586746916866)), timestamp: 1772747466, clock: EventClock(1 => 817514586264571905), target: User(UserId(Snowflake(817514586746916864))), 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(817514586746916865)), NewUserConnection { user: UserId(Snowflake(817514586746916864)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747466 })) }) }; event clock=EventClock(1 => 817514586264571905) my clock=EventClock(1 => 817514586264571905) 1772747466.167 S -> chanop: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.167434Z#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 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.167727Z#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(817514586746916866)), timestamp: 1772747466, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514586746916864)), 1) }), users_to_notify: [] }) 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.167772Z#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(817514586746916866)), timestamp: 1772747466, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514586746916864)), 1) }), users_to_notify: [] } 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.167842Z#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(817514586746916866)), timestamp: 1772747466, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514586746916864)), 2), connection: UserConnectionId(Snowflake(817514586746916865)) }), users_to_notify: [] }) 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.167878Z#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(817514586746916866)), timestamp: 1772747466, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514586746916864)), 2), connection: UserConnectionId(Snowflake(817514586746916865)) }), users_to_notify: [] } 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.167945Z#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 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.167989Z#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 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.168037Z#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-05 21:51:06.168022265 UTC 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.168081Z#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 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.168142Z#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 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.168186Z#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 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.168238Z#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 + 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.168276Z#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. 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.168366Z#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(817514586746916866)), timestamp: 1772747466, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747466.168 sable_ircd #x1B[2m2026-03-05T21:51:06.168401Z#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(817514586746916866)), timestamp: 1772747466, change: EventComplete(EventComplete), users_to_notify: [] } 1772747466.169 S -> chanop: :My.Little.Server 001 chanop :Welcome to the test Internet Relay Chat network, chanop 1772747466.169 chanop -> S: PING foo 1772747466.169 sable_ircd #x1B[2m2026-03-05T21:51:06.168932Z#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 1772747466.169 sable_ircd #x1B[2m2026-03-05T21:51:06.168972Z#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" 1772747466.169 sable_ircd #x1B[2m2026-03-05T21:51:06.169036Z#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 1772747466.269 chanop -> S: PING synchronize303.605517405 1772747466.269 S -> chanop: :My.Little.Server 002 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747466.269 S -> chanop: :My.Little.Server 003 chanop :This server was created 2026-03-05 21:51:06.168022265 UTC 1772747466.269 S -> chanop: :My.Little.Server 004 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747466.269 S -> chanop: :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 1772747466.269 S -> chanop: :My.Little.Server 422 chanop :MOTD File is missing 1772747466.269 S -> chanop: :chanop!username@localhost MODE chanop + 1772747466.269 S -> chanop: :My.Little.Server NOTICE chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747466.269 S -> chanop: :My.Little.Server PONG My.Little.Server :foo 1772747466.269 sable_ircd #x1B[2m2026-03-05T21:51:06.269329Z#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 1772747466.269 sable_ircd #x1B[2m2026-03-05T21:51:06.269436Z#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 synchronize303.605517405" 1772747466.270 sable_ircd #x1B[2m2026-03-05T21:51:06.269553Z#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 :synchronize303.605517405 1772747466.270 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize303.605517405 1772747466.971 chanop -> S: JOIN #chan 1772747466.971 sable_ircd #x1B[2m2026-03-05T21:51:06.971394Z#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 1772747466.972 sable_ircd #x1B[2m2026-03-05T21:51:06.971477Z#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" 1772747467.071 chanop -> S: PING synchronize304.407625029 1772747467.072 sable_ircd #x1B[2m2026-03-05T21:51:07.071536Z#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 1772747467.072 sable_ircd #x1B[2m2026-03-05T21:51:07.071604Z#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 synchronize304.407625029" 1772747467.072 sable_ircd #x1B[2m2026-03-05T21:51:07.071902Z#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(817514590538567683)), timestamp: 1772747467, clock: EventClock(1 => 817514586746916866), target: Channel(ChannelId(Snowflake(817514590538567682))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 817514586746916866) my clock=EventClock(1 => 817514586746916866) 1772747467.072 sable_ircd #x1B[2m2026-03-05T21:51:07.072075Z#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 1772747467.072 sable_ircd #x1B[2m2026-03-05T21:51:07.072174Z#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(817514590542761988)), timestamp: 1772747467, clock: EventClock(1 => 817514590538567683), target: Membership(MembershipId(UserId(Snowflake(817514586746916864)), ChannelId(Snowflake(817514590538567682)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(817514590538567682)), user: UserId(Snowflake(817514586746916864)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 817514590538567683) my clock=EventClock(1 => 817514590538567683) 1772747467.072 sable_ircd #x1B[2m2026-03-05T21:51:07.072302Z#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 1772747467.072 sable_ircd #x1B[2m2026-03-05T21:51:07.072367Z#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 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.072601Z#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(817514590538567683)), timestamp: 1772747467, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.072643Z#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(817514590538567683)), timestamp: 1772747467, change: EventComplete(EventComplete), users_to_notify: [] } 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.072713Z#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(817514590542761988)), timestamp: 1772747467, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514586746916864)), ChannelId(Snowflake(817514590538567682))), user: HistoricUserId(UserId(Snowflake(817514586746916864)), 2) }), users_to_notify: [UserId(Snowflake(817514586746916864))] }) 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.072751Z#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(817514590542761988)), timestamp: 1772747467, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514586746916864)), ChannelId(Snowflake(817514590538567682))), user: HistoricUserId(UserId(Snowflake(817514586746916864)), 2) }), users_to_notify: [UserId(Snowflake(817514586746916864))] } 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.072820Z#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 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.072874Z#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 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.072941Z#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 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.072982Z#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 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.073033Z#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(817514590542761988)), timestamp: 1772747467, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747467.073 sable_ircd #x1B[2m2026-03-05T21:51:07.073067Z#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(817514590542761988)), timestamp: 1772747467, change: EventComplete(EventComplete), users_to_notify: [] } 1772747467.073 S -> chanop: :chanop!username@localhost JOIN #chan 1772747467.073 S -> chanop: :chanop!username@localhost MODE #chan +o chanop 1772747467.073 S -> chanop: :My.Little.Server 353 chanop = #chan :@chanop 1772747467.073 S -> chanop: :My.Little.Server 366 chanop #chan :End of names list 1772747468.075 chanop: waiting… 1772747468.078 sable_ircd #x1B[2m2026-03-05T21:51:08.077510Z#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 :synchronize304.407625029 1772747468.078 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize304.407625029 1772747468.178 chanop -> S: PING synchronize305.51464416 1772747468.178 sable_ircd #x1B[2m2026-03-05T21:51:08.178425Z#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 1772747468.179 sable_ircd #x1B[2m2026-03-05T21:51:08.178481Z#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 synchronize305.51464416" 1772747469.178 chanop: waiting… 1772747469.183 sable_ircd #x1B[2m2026-03-05T21:51:09.182832Z#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 :synchronize305.51464416 1772747469.183 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize305.51464416 1772747469.183 chanop -> S: MODE #chan +i 1772747469.184 sable_ircd #x1B[2m2026-03-05T21:51:09.183707Z#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 1772747469.184 sable_ircd #x1B[2m2026-03-05T21:51:09.183768Z#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 +i" 1772747469.284 chanop -> S: PING synchronize306.62067253 1772747469.285 sable_ircd #x1B[2m2026-03-05T21:51:09.284524Z#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 1772747469.285 sable_ircd #x1B[2m2026-03-05T21:51:09.284590Z#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 synchronize306.62067253" 1772747470.039 sable_ircd #x1B[2m2026-03-05T21:51:10.038522Z#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(817514602983067653)), timestamp: 1772747470, clock: EventClock(1 => 817514590542761988), target: Channel(ChannelId(Snowflake(817514590538567682))), details: ChannelModeChange(ChannelModeChange { changed_by: User(UserId(Snowflake(817514586746916864))), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange }) }; event clock=EventClock(1 => 817514590542761988) my clock=EventClock(1 => 817514590542761988) 1772747470.039 sable_ircd #x1B[2m2026-03-05T21:51:10.038703Z#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 1772747470.039 sable_ircd #x1B[2m2026-03-05T21:51:10.038718Z#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 1772747470.039 sable_ircd #x1B[2m2026-03-05T21:51:10.038985Z#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(817514602983067653)), timestamp: 1772747470, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(817514590538567682)), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(817514586746916864)), 2)) }), users_to_notify: [UserId(Snowflake(817514586746916864))] }) 1772747470.039 sable_ircd #x1B[2m2026-03-05T21:51:10.039029Z#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(817514602983067653)), timestamp: 1772747470, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(817514590538567682)), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(817514586746916864)), 2)) }), users_to_notify: [UserId(Snowflake(817514586746916864))] } 1772747470.039 sable_ircd #x1B[2m2026-03-05T21:51:10.039096Z#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 +i 1772747470.039 sable_ircd #x1B[2m2026-03-05T21:51:10.039153Z#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(817514602983067653)), timestamp: 1772747470, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747470.039 sable_ircd #x1B[2m2026-03-05T21:51:10.039180Z#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(817514602983067653)), timestamp: 1772747470, change: EventComplete(EventComplete), users_to_notify: [] } 1772747470.040 S -> chanop: :chanop!username@localhost MODE #chan +i 1772747471.040 chanop: waiting… 1772747471.044 sable_ircd #x1B[2m2026-03-05T21:51:11.044079Z#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 :synchronize306.62067253 1772747471.044 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize306.62067253 1772747471.045 chanop -> S: MODE #chan +I bar!*@* 1772747471.045 sable_ircd #x1B[2m2026-03-05T21:51:11.044837Z#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 1772747471.045 sable_ircd #x1B[2m2026-03-05T21:51:11.044897Z#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 +I bar!*@*" 1772747471.145 chanop -> S: PING synchronize308.481334693 1772747471.145 sable_ircd #x1B[2m2026-03-05T21:51:11.145280Z#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 1772747471.145 sable_ircd #x1B[2m2026-03-05T21:51:11.145397Z#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 synchronize308.481334693" 1772747472.146 chanop: waiting… 1772747472.151 sable_ircd #x1B[2m2026-03-05T21:51:12.150841Z#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(817514611841437702)), timestamp: 1772747472, clock: EventClock(1 => 817514602983067653), target: ListModeEntry(ListModeEntryId(Snowflake(817514611841437699))), details: NewListModeEntry(NewListModeEntry { list: ListModeId(ChannelId(Snowflake(817514590538567682)), Invex), pattern: Pattern("bar!*@*"), setter: UserId(Snowflake(817514586746916864)) }) }; event clock=EventClock(1 => 817514602983067653) my clock=EventClock(1 => 817514602983067653) 1772747472.151 sable_ircd #x1B[2m2026-03-05T21:51:12.151009Z#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 1772747472.151 sable_ircd #x1B[2m2026-03-05T21:51:12.151018Z#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 1772747472.151 sable_ircd #x1B[2m2026-03-05T21:51:12.151296Z#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(817514611841437702)), timestamp: 1772747472, change: ListModeAdded(ListModeAdded { channel: ChannelId(Snowflake(817514590538567682)), list_type: Invex, pattern: Pattern("bar!*@*"), set_by: User(HistoricUserId(UserId(Snowflake(817514586746916864)), 2)) }), users_to_notify: [UserId(Snowflake(817514586746916864))] }) 1772747472.151 sable_ircd #x1B[2m2026-03-05T21:51:12.151363Z#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(817514611841437702)), timestamp: 1772747472, change: ListModeAdded(ListModeAdded { channel: ChannelId(Snowflake(817514590538567682)), list_type: Invex, pattern: Pattern("bar!*@*"), set_by: User(HistoricUserId(UserId(Snowflake(817514586746916864)), 2)) }), users_to_notify: [UserId(Snowflake(817514586746916864))] } 1772747472.151 sable_ircd #x1B[2m2026-03-05T21:51:12.151451Z#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 +I bar!*@* 1772747472.152 sable_ircd #x1B[2m2026-03-05T21:51:12.151523Z#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(817514611841437702)), timestamp: 1772747472, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747472.152 sable_ircd #x1B[2m2026-03-05T21:51:12.151559Z#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(817514611841437702)), timestamp: 1772747472, change: EventComplete(EventComplete), users_to_notify: [] } 1772747472.152 S -> chanop: :chanop!username@localhost MODE #chan +I bar!*@* 1772747473.153 chanop: waiting… 1772747473.156 sable_ircd #x1B[2m2026-03-05T21:51:13.156012Z#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 :synchronize308.481334693 1772747473.156 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize308.481334693 1772747473.157 bar: connects to server. 1772747473.157 bar -> S: NICK Bar 1772747473.157 bar -> S: USER username * * :Realname 1772747473.157 sable_ircd #x1B[2m2026-03-05T21:51:13.156898Z#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 } 1772747473.157 sable_ircd #x1B[2m2026-03-05T21:51:13.157021Z#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 1772747473.157 sable_ircd #x1B[2m2026-03-05T21:51:13.157062Z#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 1772747473.157 sable_ircd #x1B[2m2026-03-05T21:51:13.157109Z#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 1772747473.157 sable_ircd #x1B[2m2026-03-05T21:51:13.157239Z#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 1772747473.157 sable_ircd #x1B[2m2026-03-05T21:51:13.157291Z#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 Bar" 1772747473.157 S -> bar: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.157479Z#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: 310, tv_nsec: 493761348 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("Bar")), 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 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.157536Z#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 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.157565Z#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 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.157594Z#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" 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.157657Z#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: 310, tv_nsec: 493761348 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("Bar")), 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 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.158202Z#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 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.158235Z#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")) 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.158265Z#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 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.158288Z#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: 310, tv_nsec: 493761348 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("Bar")), 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 1772747473.158 sable_ircd #x1B[2m2026-03-05T21:51:13.158330Z#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)) 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.158587Z#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(817514616069296135)), timestamp: 1772747473, clock: EventClock(1 => 817514611841437702), target: User(UserId(Snowflake(817514616069296132))), details: NewUser(NewUser { nickname: Nickname("Bar"), 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(817514616069296133)), NewUserConnection { user: UserId(Snowflake(817514616069296132)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747473 })) }) }; event clock=EventClock(1 => 817514611841437702) my clock=EventClock(1 => 817514611841437702) 1772747473.159 S -> bar: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.158686Z#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 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.158963Z#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(817514616069296135)), timestamp: 1772747473, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514616069296132)), 1) }), users_to_notify: [] }) 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159007Z#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(817514616069296135)), timestamp: 1772747473, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514616069296132)), 1) }), users_to_notify: [] } 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159060Z#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(817514616069296135)), timestamp: 1772747473, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514616069296132)), 2), connection: UserConnectionId(Snowflake(817514616069296133)) }), users_to_notify: [] }) 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159084Z#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(817514616069296135)), timestamp: 1772747473, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514616069296132)), 2), connection: UserConnectionId(Snowflake(817514616069296133)) }), users_to_notify: [] } 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159125Z#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 Bar :Welcome to the test Internet Relay Chat network, Bar 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159150Z#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 Bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159172Z#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 Bar :This server was created 2026-03-05 21:51:13.159164512 UTC 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159190Z#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 Bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159214Z#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 Bar 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 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159233Z#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 Bar :MOTD File is missing 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159249Z#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): :Bar!username@localhost MODE Bar + 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159264Z#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 Bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159296Z#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(817514616069296135)), timestamp: 1772747473, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747473.159 sable_ircd #x1B[2m2026-03-05T21:51:13.159317Z#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(817514616069296135)), timestamp: 1772747473, change: EventComplete(EventComplete), users_to_notify: [] } 1772747473.160 S -> bar: :My.Little.Server 001 Bar :Welcome to the test Internet Relay Chat network, Bar 1772747473.160 bar -> S: PING foo 1772747473.160 sable_ircd #x1B[2m2026-03-05T21:51:13.159843Z#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 1772747473.160 sable_ircd #x1B[2m2026-03-05T21:51:13.159884Z#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" 1772747473.160 sable_ircd #x1B[2m2026-03-05T21:51:13.159950Z#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 1772747473.260 bar -> S: PING synchronize310.59642671 1772747473.260 S -> bar: :My.Little.Server 002 Bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747473.260 S -> bar: :My.Little.Server 003 Bar :This server was created 2026-03-05 21:51:13.159164512 UTC 1772747473.260 S -> bar: :My.Little.Server 004 Bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747473.260 S -> bar: :My.Little.Server 005 Bar 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 1772747473.260 S -> bar: :My.Little.Server 422 Bar :MOTD File is missing 1772747473.260 S -> bar: :Bar!username@localhost MODE Bar + 1772747473.260 S -> bar: :My.Little.Server NOTICE Bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747473.260 S -> bar: :My.Little.Server PONG My.Little.Server :foo 1772747473.260 sable_ircd #x1B[2m2026-03-05T21:51:13.260207Z#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 1772747473.260 sable_ircd #x1B[2m2026-03-05T21:51:13.260275Z#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 synchronize310.59642671" 1772747473.260 sable_ircd #x1B[2m2026-03-05T21:51:13.260423Z#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 :synchronize310.59642671 1772747473.261 S -> bar: :My.Little.Server PONG My.Little.Server :synchronize310.59642671 1772747473.962 bar -> S: JOIN #chan 1772747473.962 sable_ircd #x1B[2m2026-03-05T21:51:13.962179Z#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 1772747473.962 sable_ircd #x1B[2m2026-03-05T21:51:13.962245Z#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" 1772747474.062 bar -> S: PING synchronize311.398466276 1772747474.062 sable_ircd #x1B[2m2026-03-05T21:51:14.062372Z#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 1772747474.062 sable_ircd #x1B[2m2026-03-05T21:51:14.062445Z#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 synchronize311.398466276" 1772747474.063 sable_ircd #x1B[2m2026-03-05T21:51:14.062771Z#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(817514619860946952)), timestamp: 1772747474, clock: EventClock(1 => 817514616069296135), target: Membership(MembershipId(UserId(Snowflake(817514616069296132)), ChannelId(Snowflake(817514590538567682)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(817514590538567682)), user: UserId(Snowflake(817514616069296132)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 817514616069296135) my clock=EventClock(1 => 817514616069296135) 1772747474.063 sable_ircd #x1B[2m2026-03-05T21:51:14.062938Z#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 1772747474.063 sable_ircd #x1B[2m2026-03-05T21:51:14.062945Z#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 1772747474.063 sable_ircd #x1B[2m2026-03-05T21:51:14.063188Z#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(817514619860946952)), timestamp: 1772747474, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514616069296132)), ChannelId(Snowflake(817514590538567682))), user: HistoricUserId(UserId(Snowflake(817514616069296132)), 2) }), users_to_notify: [UserId(Snowflake(817514586746916864)), UserId(Snowflake(817514616069296132))] }) 1772747474.063 sable_ircd #x1B[2m2026-03-05T21:51:14.063231Z#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(817514619860946952)), timestamp: 1772747474, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514616069296132)), ChannelId(Snowflake(817514590538567682))), user: HistoricUserId(UserId(Snowflake(817514616069296132)), 2) }), users_to_notify: [UserId(Snowflake(817514586746916864)), UserId(Snowflake(817514616069296132))] } 1772747474.063 sable_ircd #x1B[2m2026-03-05T21:51:14.063301Z#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): :Bar!username@localhost JOIN #chan 1772747474.063 sable_ircd #x1B[2m2026-03-05T21:51:14.063385Z#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): :Bar!username@localhost JOIN #chan 1772747474.063 sable_ircd #x1B[2m2026-03-05T21:51:14.063450Z#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 Bar = #chan :@chanop Bar 1772747474.064 sable_ircd #x1B[2m2026-03-05T21:51:14.063492Z#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 Bar #chan :End of names list 1772747474.064 sable_ircd #x1B[2m2026-03-05T21:51:14.063559Z#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(817514619860946952)), timestamp: 1772747474, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747474.064 sable_ircd #x1B[2m2026-03-05T21:51:14.063595Z#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(817514619860946952)), timestamp: 1772747474, change: EventComplete(EventComplete), users_to_notify: [] } 1772747474.064 S -> bar: :Bar!username@localhost JOIN #chan 1772747474.064 S -> bar: :My.Little.Server 353 Bar = #chan :@chanop Bar 1772747474.064 S -> bar: :My.Little.Server 366 Bar #chan :End of names list 1772747475.065 bar: waiting… 1772747475.069 sable_ircd #x1B[2m2026-03-05T21:51:15.069231Z#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 :synchronize311.398466276 1772747475.070 S -> bar: :My.Little.Server PONG My.Little.Server :synchronize311.398466276 1772747475.170 chanop -> S: PING synchronize312.506557591 1772747475.170 S -> chanop: :Bar!username@localhost JOIN #chan 1772747475.170 sable_ircd #x1B[2m2026-03-05T21:51:15.170366Z#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 1772747475.170 sable_ircd #x1B[2m2026-03-05T21:51:15.170428Z#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 synchronize312.506557591" 1772747475.171 sable_ircd #x1B[2m2026-03-05T21:51:15.170537Z#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 :synchronize312.506557591 1772747475.171 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize312.506557591 1772747475.171 baz: connects to server. 1772747475.171 baz -> S: NICK Baz 1772747475.171 baz -> S: USER username * * :Realname 1772747475.171 sable_ircd #x1B[2m2026-03-05T21:51:15.171330Z#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), 4), remote_addr: 127.0.0.1, tls_info: None } 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.171521Z#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 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.171579Z#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), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.171629Z#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), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Looking up your hostname 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.171757Z#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 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.171811Z#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), 4)#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 Baz" 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.171926Z#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 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.171978Z#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), 4)#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" 1772747475.172 S -> baz: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.172075Z#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: 312, tv_nsec: 508279678 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(), 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 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.172171Z#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: 312, tv_nsec: 508279678 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("Baz")), 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 1772747475.172 sable_ircd #x1B[2m2026-03-05T21:51:15.172225Z#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 1772747475.173 sable_ircd #x1B[2m2026-03-05T21:51:15.172755Z#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 1772747475.173 sable_ircd #x1B[2m2026-03-05T21:51:15.172797Z#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), 4): 127.0.0.1/Some(Hostname("localhost")) 1772747475.173 sable_ircd #x1B[2m2026-03-05T21:51:15.172834Z#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), 4): :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747475.173 sable_ircd #x1B[2m2026-03-05T21:51:15.172867Z#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: 312, tv_nsec: 508279678 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("Baz")), 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 1772747475.173 sable_ircd #x1B[2m2026-03-05T21:51:15.172926Z#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), 4)) 1772747475.173 S -> baz: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747475.173 sable_ircd #x1B[2m2026-03-05T21:51:15.173166Z#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(817514624520818697)), timestamp: 1772747475, clock: EventClock(1 => 817514619860946952), target: User(UserId(Snowflake(817514624520818694))), details: NewUser(NewUser { nickname: Nickname("Baz"), 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(817514624520818695)), NewUserConnection { user: UserId(Snowflake(817514624520818694)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747475 })) }) }; event clock=EventClock(1 => 817514619860946952) my clock=EventClock(1 => 817514619860946952) 1772747475.173 sable_ircd #x1B[2m2026-03-05T21:51:15.173252Z#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 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173517Z#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(817514624520818697)), timestamp: 1772747475, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514624520818694)), 1) }), users_to_notify: [] }) 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173559Z#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(817514624520818697)), timestamp: 1772747475, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514624520818694)), 1) }), users_to_notify: [] } 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173617Z#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(817514624520818697)), timestamp: 1772747475, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514624520818694)), 2), connection: UserConnectionId(Snowflake(817514624520818695)) }), users_to_notify: [] }) 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173652Z#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(817514624520818697)), timestamp: 1772747475, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514624520818694)), 2), connection: UserConnectionId(Snowflake(817514624520818695)) }), users_to_notify: [] } 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173711Z#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), 4): :My.Little.Server 001 Baz :Welcome to the test Internet Relay Chat network, Baz 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173752Z#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), 4): :My.Little.Server 002 Baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173791Z#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), 4): :My.Little.Server 003 Baz :This server was created 2026-03-05 21:51:15.173777810 UTC 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173834Z#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), 4): :My.Little.Server 004 Baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173882Z#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), 4): :My.Little.Server 005 Baz 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 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173927Z#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), 4): :My.Little.Server 422 Baz :MOTD File is missing 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.173972Z#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), 4): :Baz!username@localhost MODE Baz + 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.174014Z#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), 4): :My.Little.Server NOTICE Baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.174058Z#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(817514624520818697)), timestamp: 1772747475, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747475.174 sable_ircd #x1B[2m2026-03-05T21:51:15.174093Z#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(817514624520818697)), timestamp: 1772747475, change: EventComplete(EventComplete), users_to_notify: [] } 1772747475.174 S -> baz: :My.Little.Server 001 Baz :Welcome to the test Internet Relay Chat network, Baz 1772747475.174 S -> baz: :My.Little.Server 002 Baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747475.174 S -> baz: :My.Little.Server 003 Baz :This server was created 2026-03-05 21:51:15.173777810 UTC 1772747475.175 baz -> S: PING foo 1772747475.175 sable_ircd #x1B[2m2026-03-05T21:51:15.174739Z#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 1772747475.175 sable_ircd #x1B[2m2026-03-05T21:51:15.174792Z#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), 4)#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" 1772747475.175 sable_ircd #x1B[2m2026-03-05T21:51:15.174894Z#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), 4): :My.Little.Server PONG My.Little.Server :foo 1772747475.475 baz -> S: PING synchronize312.811440826 1772747475.475 S -> baz: :My.Little.Server 004 Baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747475.475 S -> baz: :My.Little.Server 005 Baz 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 1772747475.475 S -> baz: :My.Little.Server 422 Baz :MOTD File is missing 1772747475.475 S -> baz: :Baz!username@localhost MODE Baz + 1772747475.475 S -> baz: :My.Little.Server NOTICE Baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747475.475 S -> baz: :My.Little.Server PONG My.Little.Server :foo 1772747475.475 sable_ircd #x1B[2m2026-03-05T21:51:15.475283Z#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 1772747475.475 sable_ircd #x1B[2m2026-03-05T21:51:15.475388Z#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), 4)#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 synchronize312.811440826" 1772747475.476 sable_ircd #x1B[2m2026-03-05T21:51:15.475560Z#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), 4): :My.Little.Server PONG My.Little.Server :synchronize312.811440826 1772747475.476 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize312.811440826 1772747475.976 baz -> S: JOIN #chan 1772747475.977 sable_ircd #x1B[2m2026-03-05T21:51:15.976832Z#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 1772747475.977 sable_ircd #x1B[2m2026-03-05T21:51:15.976899Z#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), 4)#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" 1772747476.077 baz -> S: PING synchronize313.413541969 1772747476.079 sable_ircd #x1B[2m2026-03-05T21:51:16.078954Z#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 1772747476.079 sable_ircd #x1B[2m2026-03-05T21:51:16.079027Z#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), 4)#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 synchronize313.413541969" 1772747476.079 sable_ircd #x1B[2m2026-03-05T21:51:16.079246Z#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), 4): :My.Little.Server 473 Baz #chan :Cannot join channel (+i) - you must be invited 1772747476.079 sable_ircd #x1B[2m2026-03-05T21:51:16.079297Z#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 1772747476.080 S -> baz: :My.Little.Server 473 Baz #chan :Cannot join channel (+i) - you must be invited 1772747477.081 baz: waiting… 1772747477.084 sable_ircd #x1B[2m2026-03-05T21:51:17.083965Z#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), 4): :My.Little.Server PONG My.Little.Server :synchronize313.413541969 1772747477.084 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize313.413541969 1772747477.084 chanop -> S: MODE #chan +I baz!*@* 1772747477.085 sable_ircd #x1B[2m2026-03-05T21:51:17.084779Z#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 1772747477.085 sable_ircd #x1B[2m2026-03-05T21:51:17.084822Z#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 +I baz!*@*" 1772747477.085 sable_ircd #x1B[2m2026-03-05T21:51:17.085023Z#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(817514632540327946)), timestamp: 1772747477, clock: EventClock(1 => 817514624520818697), target: ListModeEntry(ListModeEntryId(Snowflake(817514632536133640))), details: NewListModeEntry(NewListModeEntry { list: ListModeId(ChannelId(Snowflake(817514590538567682)), Invex), pattern: Pattern("baz!*@*"), setter: UserId(Snowflake(817514586746916864)) }) }; event clock=EventClock(1 => 817514624520818697) my clock=EventClock(1 => 817514624520818697) 1772747477.085 sable_ircd #x1B[2m2026-03-05T21:51:17.085134Z#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 1772747477.085 sable_ircd #x1B[2m2026-03-05T21:51:17.085155Z#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 1772747477.085 sable_ircd #x1B[2m2026-03-05T21:51:17.085415Z#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(817514632540327946)), timestamp: 1772747477, change: ListModeAdded(ListModeAdded { channel: ChannelId(Snowflake(817514590538567682)), list_type: Invex, pattern: Pattern("baz!*@*"), set_by: User(HistoricUserId(UserId(Snowflake(817514586746916864)), 2)) }), users_to_notify: [UserId(Snowflake(817514586746916864))] }) 1772747477.085 sable_ircd #x1B[2m2026-03-05T21:51:17.085452Z#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(817514632540327946)), timestamp: 1772747477, change: ListModeAdded(ListModeAdded { channel: ChannelId(Snowflake(817514590538567682)), list_type: Invex, pattern: Pattern("baz!*@*"), set_by: User(HistoricUserId(UserId(Snowflake(817514586746916864)), 2)) }), users_to_notify: [UserId(Snowflake(817514586746916864))] } 1772747477.086 sable_ircd #x1B[2m2026-03-05T21:51:17.085502Z#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 +I baz!*@* 1772747477.086 sable_ircd #x1B[2m2026-03-05T21:51:17.085555Z#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(817514632540327946)), timestamp: 1772747477, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747477.086 sable_ircd #x1B[2m2026-03-05T21:51:17.085579Z#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(817514632540327946)), timestamp: 1772747477, change: EventComplete(EventComplete), users_to_notify: [] } 1772747477.185 chanop -> S: PING synchronize314.521236682 1772747477.185 S -> chanop: :chanop!username@localhost MODE #chan +I baz!*@* 1772747477.185 sable_ircd #x1B[2m2026-03-05T21:51:17.185052Z#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 1772747477.185 sable_ircd #x1B[2m2026-03-05T21:51:17.185157Z#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 synchronize314.521236682" 1772747477.185 sable_ircd #x1B[2m2026-03-05T21:51:17.185330Z#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 :synchronize314.521236682 1772747477.186 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize314.521236682 1772747477.186 baz -> S: JOIN #chan 1772747477.186 sable_ircd #x1B[2m2026-03-05T21:51:17.186116Z#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 1772747477.186 sable_ircd #x1B[2m2026-03-05T21:51:17.186158Z#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), 4)#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" 1772747477.286 baz -> S: PING synchronize314.622581251 1772747477.287 sable_ircd #x1B[2m2026-03-05T21:51:17.286498Z#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 1772747477.287 sable_ircd #x1B[2m2026-03-05T21:51:17.286573Z#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), 4)#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 synchronize314.622581251" 1772747478.041 sable_ircd #x1B[2m2026-03-05T21:51:18.040493Z#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(817514636545888267)), timestamp: 1772747478, clock: EventClock(1 => 817514632540327946), target: Membership(MembershipId(UserId(Snowflake(817514624520818694)), ChannelId(Snowflake(817514590538567682)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(817514590538567682)), user: UserId(Snowflake(817514624520818694)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 817514632540327946) my clock=EventClock(1 => 817514632540327946) 1772747478.041 sable_ircd #x1B[2m2026-03-05T21:51:18.040666Z#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 1772747478.041 sable_ircd #x1B[2m2026-03-05T21:51:18.040763Z#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 1772747478.041 sable_ircd #x1B[2m2026-03-05T21:51:18.041072Z#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(817514636545888267)), timestamp: 1772747478, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514624520818694)), ChannelId(Snowflake(817514590538567682))), user: HistoricUserId(UserId(Snowflake(817514624520818694)), 2) }), users_to_notify: [UserId(Snowflake(817514586746916864)), UserId(Snowflake(817514616069296132)), UserId(Snowflake(817514624520818694))] }) 1772747478.041 sable_ircd #x1B[2m2026-03-05T21:51:18.041123Z#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(817514636545888267)), timestamp: 1772747478, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514624520818694)), ChannelId(Snowflake(817514590538567682))), user: HistoricUserId(UserId(Snowflake(817514624520818694)), 2) }), users_to_notify: [UserId(Snowflake(817514586746916864)), UserId(Snowflake(817514616069296132)), UserId(Snowflake(817514624520818694))] } 1772747478.041 sable_ircd #x1B[2m2026-03-05T21:51:18.041202Z#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): :Baz!username@localhost JOIN #chan 1772747478.041 sable_ircd #x1B[2m2026-03-05T21:51:18.041264Z#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): :Baz!username@localhost JOIN #chan 1772747478.041 sable_ircd #x1B[2m2026-03-05T21:51:18.041356Z#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), 4): :Baz!username@localhost JOIN #chan 1772747478.041 sable_ircd #x1B[2m2026-03-05T21:51:18.041436Z#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), 4): :My.Little.Server 353 Baz = #chan :@chanop Bar Baz 1772747478.042 sable_ircd #x1B[2m2026-03-05T21:51:18.041486Z#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), 4): :My.Little.Server 366 Baz #chan :End of names list 1772747478.042 sable_ircd #x1B[2m2026-03-05T21:51:18.041553Z#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(817514636545888267)), timestamp: 1772747478, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747478.042 sable_ircd #x1B[2m2026-03-05T21:51:18.041595Z#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(817514636545888267)), timestamp: 1772747478, change: EventComplete(EventComplete), users_to_notify: [] } 1772747478.042 S -> baz: :Baz!username@localhost JOIN #chan 1772747478.042 S -> baz: :My.Little.Server 353 Baz = #chan :@chanop Bar Baz 1772747478.042 S -> baz: :My.Little.Server 366 Baz #chan :End of names list 1772747479.042 baz: waiting… 1772747479.047 sable_ircd #x1B[2m2026-03-05T21:51:19.047184Z#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), 4): :My.Little.Server PONG My.Little.Server :synchronize314.622581251 1772747479.048 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize314.622581251 1772747479.051 chanop: disconnects from server. 1772747479.051 bar: disconnects from server. 1772747479.051 baz: disconnects from server.