--------------------------------- Captured Out --------------------------------- ---- new test ---- 1772747520.142 sable_ircd uid=1001 1772747520.147 sable_ircd #x1B[2m2026-03-05T21:52:00.146071Z#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(817514813151252480)), timestamp: 1772747520, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747520, name: ServerName("My.Little.Server"), ts: 1772747520, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1772747520.147 sable_ircd #x1B[2m2026-03-05T21:52:00.146189Z#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 1772747520.147 sable_ircd #x1B[2m2026-03-05T21:52:00.146482Z#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(817514813151252480)), timestamp: 1772747520, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747520, name: ServerName("My.Little.Server"), ts: 1772747520, 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 1772747520.147 sable_ircd #x1B[2m2026-03-05T21:52:00.146600Z#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(817514813151252480)), timestamp: 1772747520, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1772747520.147 sable_ircd #x1B[2m2026-03-05T21:52:00.146642Z#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(817514813151252480)), timestamp: 1772747520, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1772747520.147 sable_ircd #x1B[2m2026-03-05T21:52:00.146690Z#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(817514813151252480)), timestamp: 1772747520, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747520.147 sable_ircd #x1B[2m2026-03-05T21:52:00.146720Z#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(817514813151252480)), timestamp: 1772747520, change: EventComplete(EventComplete), users_to_notify: [] } 1772747520.148 sable_ircd #x1B[2m2026-03-05T21:52:00.147827Z#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 1772747520.148 sable_ircd #x1B[2m2026-03-05T21:52:00.147900Z#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(817514813155446785)), timestamp: 1772747520, clock: EventClock(1 => 817514813151252480), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1772747520 }) }; event clock=EventClock(1 => 817514813151252480) my clock=EventClock(1 => 817514813151252480) 1772747520.148 sable_ircd #x1B[2m2026-03-05T21:52:00.147961Z#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 1772747520.148 sable_ircd #x1B[2m2026-03-05T21:52:00.148184Z#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(817514813155446785)), timestamp: 1772747520, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747520.148 sable_ircd #x1B[2m2026-03-05T21:52:00.148221Z#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(817514813155446785)), timestamp: 1772747520, change: EventComplete(EventComplete), users_to_notify: [] } 1772747520.238 sable_ircd #x1B[2m2026-03-05T21:52:00.237959Z#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 } 1772747520.238 sable_ircd #x1B[2m2026-03-05T21:52:00.238093Z#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 1772747520.238 sable_ircd #x1B[2m2026-03-05T21:52:00.238144Z#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 1772747520.238 sable_ircd #x1B[2m2026-03-05T21:52:00.238211Z#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 1772747520.238 sable_ircd #x1B[2m2026-03-05T21:52:00.238401Z#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 1772747520.239 sable_ircd #x1B[2m2026-03-05T21:52:00.238484Z#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" 1772747520.239 sable_ircd #x1B[2m2026-03-05T21:52:00.238615Z#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 1772747520.239 sable_ircd #x1B[2m2026-03-05T21:52:00.238704Z#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)) 1772747520.239 sable_ircd #x1B[2m2026-03-05T21:52:00.238739Z#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) 1772747520.239 sable_ircd #x1B[2m2026-03-05T21:52:00.239198Z#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 1772747520.239 sable_ircd #x1B[2m2026-03-05T21:52:00.239294Z#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 1772747520.240 sable_ircd #x1B[2m2026-03-05T21:52:00.239500Z#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 1772747520.259 chanop: connects to server. 1772747520.259 chanop -> S: NICK chanop 1772747520.259 chanop -> S: USER username * * :Realname 1772747520.259 sable_ircd #x1B[2m2026-03-05T21:52:00.259268Z#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 } 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.259462Z#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 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.259513Z#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 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.259576Z#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 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.259709Z#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 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.259764Z#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" 1772747520.260 S -> chanop: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.259940Z#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: 357, tv_nsec: 596220511 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("chanop")), 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 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.260003Z#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 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.260050Z#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 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.260081Z#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" 1772747520.260 sable_ircd #x1B[2m2026-03-05T21:52:00.260150Z#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: 357, tv_nsec: 596220511 }, 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 1772747520.261 sable_ircd #x1B[2m2026-03-05T21:52:00.260693Z#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 1772747520.261 sable_ircd #x1B[2m2026-03-05T21:52:00.260747Z#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")) 1772747520.261 sable_ircd #x1B[2m2026-03-05T21:52:00.260790Z#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 1772747520.261 sable_ircd #x1B[2m2026-03-05T21:52:00.260832Z#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: 357, tv_nsec: 596220511 }, 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 1772747520.261 sable_ircd #x1B[2m2026-03-05T21:52:00.260899Z#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)) 1772747520.261 sable_ircd #x1B[2m2026-03-05T21:52:00.261159Z#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(817514813633597442)), timestamp: 1772747520, clock: EventClock(1 => 817514813155446785), target: User(UserId(Snowflake(817514813633597440))), 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(817514813633597441)), NewUserConnection { user: UserId(Snowflake(817514813633597440)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747520 })) }) }; event clock=EventClock(1 => 817514813155446785) my clock=EventClock(1 => 817514813155446785) 1772747520.261 S -> chanop: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747520.261 sable_ircd #x1B[2m2026-03-05T21:52:00.261284Z#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 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261585Z#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(817514813633597442)), timestamp: 1772747520, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514813633597440)), 1) }), users_to_notify: [] }) 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261626Z#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(817514813633597442)), timestamp: 1772747520, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514813633597440)), 1) }), users_to_notify: [] } 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261677Z#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(817514813633597442)), timestamp: 1772747520, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514813633597440)), 2), connection: UserConnectionId(Snowflake(817514813633597441)) }), users_to_notify: [] }) 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261701Z#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(817514813633597442)), timestamp: 1772747520, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514813633597440)), 2), connection: UserConnectionId(Snowflake(817514813633597441)) }), users_to_notify: [] } 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261746Z#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 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261772Z#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 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261793Z#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:52:00.261785834 UTC 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261810Z#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 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261842Z#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 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261862Z#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 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261880Z#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 + 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261895Z#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. 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261935Z#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(817514813633597442)), timestamp: 1772747520, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747520.262 sable_ircd #x1B[2m2026-03-05T21:52:00.261957Z#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(817514813633597442)), timestamp: 1772747520, change: EventComplete(EventComplete), users_to_notify: [] } 1772747520.262 S -> chanop: :My.Little.Server 001 chanop :Welcome to the test Internet Relay Chat network, chanop 1772747520.262 S -> chanop: :My.Little.Server 002 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747520.262 chanop -> S: PING foo 1772747520.263 sable_ircd #x1B[2m2026-03-05T21:52:00.262535Z#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 1772747520.263 sable_ircd #x1B[2m2026-03-05T21:52:00.262588Z#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" 1772747520.263 sable_ircd #x1B[2m2026-03-05T21:52:00.262685Z#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 1772747520.463 chanop -> S: PING synchronize357.799181015 1772747520.463 S -> chanop: :My.Little.Server 003 chanop :This server was created 2026-03-05 21:52:00.261785834 UTC 1772747520.463 S -> chanop: :My.Little.Server 004 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747520.463 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 1772747520.463 S -> chanop: :My.Little.Server 422 chanop :MOTD File is missing 1772747520.463 S -> chanop: :chanop!username@localhost MODE chanop + 1772747520.463 S -> chanop: :My.Little.Server NOTICE chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747520.463 S -> chanop: :My.Little.Server PONG My.Little.Server :foo 1772747520.463 sable_ircd #x1B[2m2026-03-05T21:52:00.463234Z#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 1772747520.463 sable_ircd #x1B[2m2026-03-05T21:52:00.463320Z#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 synchronize357.799181015" 1772747520.464 sable_ircd #x1B[2m2026-03-05T21:52:00.463494Z#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 :synchronize357.799181015 1772747520.464 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize357.799181015 1772747521.065 chanop -> S: JOIN #chan 1772747521.065 sable_ircd #x1B[2m2026-03-05T21:52:01.065114Z#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 1772747521.065 sable_ircd #x1B[2m2026-03-05T21:52:01.065206Z#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" 1772747521.066 sable_ircd #x1B[2m2026-03-05T21:52:01.065585Z#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(817514817005817859)), timestamp: 1772747521, clock: EventClock(1 => 817514813633597442), target: Channel(ChannelId(Snowflake(817514817005817858))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 817514813633597442) my clock=EventClock(1 => 817514813633597442) 1772747521.066 sable_ircd #x1B[2m2026-03-05T21:52:01.065779Z#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 1772747521.066 sable_ircd #x1B[2m2026-03-05T21:52:01.065875Z#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(817514817005817860)), timestamp: 1772747521, clock: EventClock(1 => 817514817005817859), target: Membership(MembershipId(UserId(Snowflake(817514813633597440)), ChannelId(Snowflake(817514817005817858)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(817514817005817858)), user: UserId(Snowflake(817514813633597440)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 817514817005817859) my clock=EventClock(1 => 817514817005817859) 1772747521.066 sable_ircd #x1B[2m2026-03-05T21:52:01.066004Z#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 1772747521.066 sable_ircd #x1B[2m2026-03-05T21:52:01.066091Z#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 1772747521.066 sable_ircd #x1B[2m2026-03-05T21:52:01.066295Z#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(817514817005817859)), timestamp: 1772747521, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747521.066 sable_ircd #x1B[2m2026-03-05T21:52:01.066330Z#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(817514817005817859)), timestamp: 1772747521, change: EventComplete(EventComplete), users_to_notify: [] } 1772747521.066 sable_ircd #x1B[2m2026-03-05T21:52:01.066396Z#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(817514817005817860)), timestamp: 1772747521, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514813633597440)), ChannelId(Snowflake(817514817005817858))), user: HistoricUserId(UserId(Snowflake(817514813633597440)), 2) }), users_to_notify: [UserId(Snowflake(817514813633597440))] }) 1772747521.066 sable_ircd #x1B[2m2026-03-05T21:52:01.066424Z#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(817514817005817860)), timestamp: 1772747521, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514813633597440)), ChannelId(Snowflake(817514817005817858))), user: HistoricUserId(UserId(Snowflake(817514813633597440)), 2) }), users_to_notify: [UserId(Snowflake(817514813633597440))] } 1772747521.067 sable_ircd #x1B[2m2026-03-05T21:52:01.066477Z#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 1772747521.067 sable_ircd #x1B[2m2026-03-05T21:52:01.066513Z#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 1772747521.067 sable_ircd #x1B[2m2026-03-05T21:52:01.066554Z#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 1772747521.067 sable_ircd #x1B[2m2026-03-05T21:52:01.066575Z#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 1772747521.067 sable_ircd #x1B[2m2026-03-05T21:52:01.066611Z#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(817514817005817860)), timestamp: 1772747521, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747521.067 sable_ircd #x1B[2m2026-03-05T21:52:01.066632Z#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(817514817005817860)), timestamp: 1772747521, change: EventComplete(EventComplete), users_to_notify: [] } 1772747521.165 chanop -> S: PING synchronize358.501432849 1772747521.165 S -> chanop: :chanop!username@localhost JOIN #chan 1772747521.165 S -> chanop: :chanop!username@localhost MODE #chan +o chanop 1772747521.165 S -> chanop: :My.Little.Server 353 chanop = #chan :@chanop 1772747521.165 S -> chanop: :My.Little.Server 366 chanop #chan :End of names list 1772747521.165 sable_ircd #x1B[2m2026-03-05T21:52:01.165264Z#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 1772747521.165 sable_ircd #x1B[2m2026-03-05T21:52:01.165321Z#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 synchronize358.501432849" 1772747522.166 chanop: waiting… 1772747522.172 sable_ircd #x1B[2m2026-03-05T21:52:02.171602Z#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 :synchronize358.501432849 1772747522.172 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize358.501432849 1772747522.272 chanop -> S: PING synchronize359.608910833 1772747522.273 sable_ircd #x1B[2m2026-03-05T21:52:02.272853Z#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 1772747522.273 sable_ircd #x1B[2m2026-03-05T21:52:02.272945Z#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 synchronize359.608910833" 1772747523.027 sable_ircd #x1B[2m2026-03-05T21:52:03.026813Z#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 :synchronize359.608910833 1772747523.027 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize359.608910833 1772747523.027 chanop -> S: MODE #chan +m 1772747523.028 sable_ircd #x1B[2m2026-03-05T21:52:03.027726Z#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 1772747523.028 sable_ircd #x1B[2m2026-03-05T21:52:03.027797Z#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 +m" 1772747523.128 chanop -> S: PING synchronize360.4642767 1772747523.128 sable_ircd #x1B[2m2026-03-05T21:52:03.128203Z#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 1772747523.128 sable_ircd #x1B[2m2026-03-05T21:52:03.128294Z#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 synchronize360.4642767" 1772747524.129 chanop: waiting… 1772747524.135 sable_ircd #x1B[2m2026-03-05T21:52:04.134869Z#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(817514829878136837)), timestamp: 1772747524, clock: EventClock(1 => 817514817005817860), target: Channel(ChannelId(Snowflake(817514817005817858))), details: ChannelModeChange(ChannelModeChange { changed_by: User(UserId(Snowflake(817514813633597440))), added: ChannelModeSet(16), removed: ChannelModeSet(0), key_change: NoChange }) }; event clock=EventClock(1 => 817514817005817860) my clock=EventClock(1 => 817514817005817860) 1772747524.135 sable_ircd #x1B[2m2026-03-05T21:52:04.135046Z#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 1772747524.135 sable_ircd #x1B[2m2026-03-05T21:52:04.135054Z#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 1772747524.135 sable_ircd #x1B[2m2026-03-05T21:52:04.135369Z#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(817514829878136837)), timestamp: 1772747524, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(817514817005817858)), added: ChannelModeSet(16), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(817514813633597440)), 2)) }), users_to_notify: [UserId(Snowflake(817514813633597440))] }) 1772747524.135 sable_ircd #x1B[2m2026-03-05T21:52:04.135415Z#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(817514829878136837)), timestamp: 1772747524, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(817514817005817858)), added: ChannelModeSet(16), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(817514813633597440)), 2)) }), users_to_notify: [UserId(Snowflake(817514813633597440))] } 1772747524.136 sable_ircd #x1B[2m2026-03-05T21:52:04.135481Z#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 +m 1772747524.136 sable_ircd #x1B[2m2026-03-05T21:52:04.135545Z#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(817514829878136837)), timestamp: 1772747524, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747524.136 sable_ircd #x1B[2m2026-03-05T21:52:04.135567Z#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(817514829878136837)), timestamp: 1772747524, change: EventComplete(EventComplete), users_to_notify: [] } 1772747524.136 S -> chanop: :chanop!username@localhost MODE #chan +m 1772747525.136 chanop: waiting… 1772747525.140 sable_ircd #x1B[2m2026-03-05T21:52:05.140133Z#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 :synchronize360.4642767 1772747525.141 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize360.4642767 1772747525.141 baz: connects to server. 1772747525.141 baz -> S: NICK baz 1772747525.141 baz -> S: USER username * * :Realname 1772747525.141 sable_ircd #x1B[2m2026-03-05T21:52:05.141039Z#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 } 1772747525.141 sable_ircd #x1B[2m2026-03-05T21:52:05.141181Z#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 1772747525.141 sable_ircd #x1B[2m2026-03-05T21:52:05.141239Z#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 1772747525.141 sable_ircd #x1B[2m2026-03-05T21:52:05.141312Z#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 1772747525.142 sable_ircd #x1B[2m2026-03-05T21:52:05.141516Z#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 1772747525.142 sable_ircd #x1B[2m2026-03-05T21:52:05.141567Z#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 baz" 1772747525.142 S -> baz: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747525.142 sable_ircd #x1B[2m2026-03-05T21:52:05.141722Z#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: 362, tv_nsec: 477956497 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("baz")), 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 1772747525.142 sable_ircd #x1B[2m2026-03-05T21:52:05.141800Z#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 1772747525.142 sable_ircd #x1B[2m2026-03-05T21:52:05.141863Z#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 1772747525.142 sable_ircd #x1B[2m2026-03-05T21:52:05.141918Z#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" 1772747525.142 sable_ircd #x1B[2m2026-03-05T21:52:05.141991Z#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: 362, tv_nsec: 477956497 }, 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 1772747525.143 sable_ircd #x1B[2m2026-03-05T21:52:05.142613Z#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 1772747525.143 sable_ircd #x1B[2m2026-03-05T21:52:05.142650Z#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")) 1772747525.143 sable_ircd #x1B[2m2026-03-05T21:52:05.142690Z#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 1772747525.143 sable_ircd #x1B[2m2026-03-05T21:52:05.142727Z#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: 362, tv_nsec: 477956497 }, 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 1772747525.143 sable_ircd #x1B[2m2026-03-05T21:52:05.142791Z#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)) 1772747525.143 sable_ircd #x1B[2m2026-03-05T21:52:05.143039Z#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(817514834110189574)), timestamp: 1772747525, clock: EventClock(1 => 817514829878136837), target: User(UserId(Snowflake(817514834105995267))), 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(817514834105995268)), NewUserConnection { user: UserId(Snowflake(817514834105995267)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747525 })) }) }; event clock=EventClock(1 => 817514829878136837) my clock=EventClock(1 => 817514829878136837) 1772747525.143 sable_ircd #x1B[2m2026-03-05T21:52:05.143135Z#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 1772747525.143 S -> baz: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747525.143 sable_ircd #x1B[2m2026-03-05T21:52:05.143448Z#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(817514834110189574)), timestamp: 1772747525, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514834105995267)), 1) }), users_to_notify: [] }) 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143490Z#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(817514834110189574)), timestamp: 1772747525, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514834105995267)), 1) }), users_to_notify: [] } 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143529Z#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(817514834110189574)), timestamp: 1772747525, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514834105995267)), 2), connection: UserConnectionId(Snowflake(817514834105995268)) }), users_to_notify: [] }) 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143550Z#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(817514834110189574)), timestamp: 1772747525, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514834105995267)), 2), connection: UserConnectionId(Snowflake(817514834105995268)) }), users_to_notify: [] } 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143591Z#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 baz :Welcome to the test Internet Relay Chat network, baz 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143618Z#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 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143639Z#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 baz :This server was created 2026-03-05 21:52:05.143632021 UTC 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143656Z#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 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143677Z#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 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 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143695Z#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 baz :MOTD File is missing 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143715Z#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 MODE baz + 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143732Z#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 baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143760Z#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(817514834110189574)), timestamp: 1772747525, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.143779Z#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(817514834110189574)), timestamp: 1772747525, change: EventComplete(EventComplete), users_to_notify: [] } 1772747525.144 S -> baz: :My.Little.Server 001 baz :Welcome to the test Internet Relay Chat network, baz 1772747525.144 baz -> S: PING foo 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.144323Z#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 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.144393Z#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" 1772747525.144 sable_ircd #x1B[2m2026-03-05T21:52:05.144461Z#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 1772747525.244 baz -> S: PING synchronize362.580829285 1772747525.244 S -> baz: :My.Little.Server 002 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747525.244 S -> baz: :My.Little.Server 003 baz :This server was created 2026-03-05 21:52:05.143632021 UTC 1772747525.244 S -> baz: :My.Little.Server 004 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747525.244 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 1772747525.244 S -> baz: :My.Little.Server 422 baz :MOTD File is missing 1772747525.244 S -> baz: :baz!username@localhost MODE baz + 1772747525.244 S -> baz: :My.Little.Server NOTICE baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747525.244 S -> baz: :My.Little.Server PONG My.Little.Server :foo 1772747525.245 sable_ircd #x1B[2m2026-03-05T21:52:05.244673Z#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 1772747525.245 sable_ircd #x1B[2m2026-03-05T21:52:05.244735Z#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 synchronize362.580829285" 1772747525.245 sable_ircd #x1B[2m2026-03-05T21:52:05.244854Z#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 :synchronize362.580829285 1772747525.245 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize362.580829285 1772747525.946 baz -> S: JOIN #chan 1772747525.947 sable_ircd #x1B[2m2026-03-05T21:52:05.946469Z#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 1772747525.947 sable_ircd #x1B[2m2026-03-05T21:52:05.946533Z#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" 1772747526.046 baz -> S: PING synchronize363.382811285 1772747526.047 sable_ircd #x1B[2m2026-03-05T21:52:06.046673Z#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 1772747526.047 sable_ircd #x1B[2m2026-03-05T21:52:06.046746Z#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 synchronize363.382811285" 1772747526.047 sable_ircd #x1B[2m2026-03-05T21:52:06.047056Z#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(817514837901840391)), timestamp: 1772747526, clock: EventClock(1 => 817514834110189574), target: Membership(MembershipId(UserId(Snowflake(817514834105995267)), ChannelId(Snowflake(817514817005817858)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(817514817005817858)), user: UserId(Snowflake(817514834105995267)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 817514834110189574) my clock=EventClock(1 => 817514834110189574) 1772747526.047 sable_ircd #x1B[2m2026-03-05T21:52:06.047208Z#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 1772747526.047 sable_ircd #x1B[2m2026-03-05T21:52:06.047211Z#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 1772747526.048 sable_ircd #x1B[2m2026-03-05T21:52:06.047494Z#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(817514837901840391)), timestamp: 1772747526, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514834105995267)), ChannelId(Snowflake(817514817005817858))), user: HistoricUserId(UserId(Snowflake(817514834105995267)), 2) }), users_to_notify: [UserId(Snowflake(817514834105995267)), UserId(Snowflake(817514813633597440))] }) 1772747526.048 sable_ircd #x1B[2m2026-03-05T21:52:06.047540Z#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(817514837901840391)), timestamp: 1772747526, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514834105995267)), ChannelId(Snowflake(817514817005817858))), user: HistoricUserId(UserId(Snowflake(817514834105995267)), 2) }), users_to_notify: [UserId(Snowflake(817514834105995267)), UserId(Snowflake(817514813633597440))] } 1772747526.048 sable_ircd #x1B[2m2026-03-05T21:52:06.047616Z#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 1772747526.048 sable_ircd #x1B[2m2026-03-05T21:52:06.047690Z#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 baz = #chan :baz @chanop 1772747526.048 sable_ircd #x1B[2m2026-03-05T21:52:06.047729Z#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 baz #chan :End of names list 1772747526.048 sable_ircd #x1B[2m2026-03-05T21:52:06.047783Z#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 1772747526.048 sable_ircd #x1B[2m2026-03-05T21:52:06.047841Z#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(817514837901840391)), timestamp: 1772747526, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747526.048 sable_ircd #x1B[2m2026-03-05T21:52:06.047876Z#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(817514837901840391)), timestamp: 1772747526, change: EventComplete(EventComplete), users_to_notify: [] } 1772747526.048 S -> baz: :baz!username@localhost JOIN #chan 1772747526.048 S -> baz: :My.Little.Server 353 baz = #chan :baz @chanop 1772747526.048 S -> baz: :My.Little.Server 366 baz #chan :End of names list 1772747527.048 baz: waiting… 1772747527.052 sable_ircd #x1B[2m2026-03-05T21:52:07.052277Z#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 :synchronize363.382811285 1772747527.053 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize363.382811285 1772747527.153 chanop -> S: PING synchronize364.489576868 1772747527.153 S -> chanop: :baz!username@localhost JOIN #chan 1772747527.154 sable_ircd #x1B[2m2026-03-05T21:52:07.153524Z#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 1772747527.154 sable_ircd #x1B[2m2026-03-05T21:52:07.153594Z#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 synchronize364.489576868" 1772747527.154 sable_ircd #x1B[2m2026-03-05T21:52:07.153725Z#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 :synchronize364.489576868 1772747527.154 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize364.489576868 1772747527.154 baz -> S: PRIVMSG #chan :hi from baz 1772747527.154 sable_ircd #x1B[2m2026-03-05T21:52:07.154390Z#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 1772747527.154 sable_ircd #x1B[2m2026-03-05T21:52:07.154444Z#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"PRIVMSG #chan :hi from baz" 1772747527.254 baz -> S: PING synchronize364.590891726 1772747527.255 sable_ircd #x1B[2m2026-03-05T21:52:07.254669Z#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 1772747527.255 sable_ircd #x1B[2m2026-03-05T21:52:07.254739Z#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 synchronize364.590891726" 1772747528.009 sable_ircd #x1B[2m2026-03-05T21:52:08.008726Z#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 404 baz #chan :Cannot send to channel 1772747528.009 sable_ircd #x1B[2m2026-03-05T21:52:08.008836Z#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 1772747528.009 S -> baz: :My.Little.Server 404 baz #chan :Cannot send to channel 1772747529.010 baz: waiting… 1772747529.014 sable_ircd #x1B[2m2026-03-05T21:52:09.013396Z#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 :synchronize364.590891726 1772747529.014 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize364.590891726 1772747529.114 chanop -> S: PING synchronize366.45071832 1772747529.115 sable_ircd #x1B[2m2026-03-05T21:52:09.114680Z#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 1772747529.115 sable_ircd #x1B[2m2026-03-05T21:52:09.114753Z#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 synchronize366.45071832" 1772747529.115 sable_ircd #x1B[2m2026-03-05T21:52:09.114886Z#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 :synchronize366.45071832 1772747529.115 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize366.45071832 1772747529.115 chanop -> S: MODE #chan +v baz 1772747529.116 sable_ircd #x1B[2m2026-03-05T21:52:09.115571Z#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 1772747529.116 sable_ircd #x1B[2m2026-03-05T21:52:09.115615Z#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 +v baz" 1772747529.116 sable_ircd #x1B[2m2026-03-05T21:52:09.115874Z#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(817514850769965064)), timestamp: 1772747529, clock: EventClock(1 => 817514837901840391), target: Membership(MembershipId(UserId(Snowflake(817514834105995267)), ChannelId(Snowflake(817514817005817858)))), details: MembershipFlagChange(MembershipFlagChange { changed_by: User(UserId(Snowflake(817514813633597440))), added: MembershipFlagSet(2), removed: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 817514837901840391) my clock=EventClock(1 => 817514837901840391) 1772747529.116 sable_ircd #x1B[2m2026-03-05T21:52:09.116020Z#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 1772747529.116 sable_ircd #x1B[2m2026-03-05T21:52:09.116046Z#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 1772747529.116 sable_ircd #x1B[2m2026-03-05T21:52:09.116275Z#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(817514850769965064)), timestamp: 1772747529, change: MembershipFlagChange(MembershipFlagChange { membership: MembershipId(UserId(Snowflake(817514834105995267)), ChannelId(Snowflake(817514817005817858))), user: HistoricUserId(UserId(Snowflake(817514834105995267)), 2), added: MembershipFlagSet(2), removed: MembershipFlagSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(817514813633597440)), 2)) }), users_to_notify: [UserId(Snowflake(817514834105995267)), UserId(Snowflake(817514813633597440))] }) 1772747529.116 sable_ircd #x1B[2m2026-03-05T21:52:09.116315Z#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(817514850769965064)), timestamp: 1772747529, change: MembershipFlagChange(MembershipFlagChange { membership: MembershipId(UserId(Snowflake(817514834105995267)), ChannelId(Snowflake(817514817005817858))), user: HistoricUserId(UserId(Snowflake(817514834105995267)), 2), added: MembershipFlagSet(2), removed: MembershipFlagSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(817514813633597440)), 2)) }), users_to_notify: [UserId(Snowflake(817514834105995267)), UserId(Snowflake(817514813633597440))] } 1772747529.116 sable_ircd #x1B[2m2026-03-05T21:52:09.116408Z#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): :chanop!username@localhost MODE #chan +v baz 1772747529.116 sable_ircd #x1B[2m2026-03-05T21:52:09.116452Z#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 +v baz 1772747529.117 sable_ircd #x1B[2m2026-03-05T21:52:09.116504Z#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(817514850769965064)), timestamp: 1772747529, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747529.117 sable_ircd #x1B[2m2026-03-05T21:52:09.116528Z#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(817514850769965064)), timestamp: 1772747529, change: EventComplete(EventComplete), users_to_notify: [] } 1772747529.215 chanop -> S: PING synchronize366.552066425 1772747529.215 S -> chanop: :chanop!username@localhost MODE #chan +v baz 1772747529.216 sable_ircd #x1B[2m2026-03-05T21:52:09.215852Z#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 1772747529.216 sable_ircd #x1B[2m2026-03-05T21:52:09.215915Z#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 synchronize366.552066425" 1772747529.216 sable_ircd #x1B[2m2026-03-05T21:52:09.216028Z#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 :synchronize366.552066425 1772747529.216 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize366.552066425 1772747529.317 baz -> S: PING synchronize366.653136961 1772747529.317 S -> baz: :chanop!username@localhost MODE #chan +v baz 1772747529.317 sable_ircd #x1B[2m2026-03-05T21:52:09.317095Z#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 1772747529.317 sable_ircd #x1B[2m2026-03-05T21:52:09.317177Z#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 synchronize366.653136961" 1772747530.071 sable_ircd #x1B[2m2026-03-05T21:52:10.071043Z#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 :synchronize366.653136961 1772747530.071 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize366.653136961 1772747530.072 baz -> S: PRIVMSG #chan :hi again from baz 1772747530.072 sable_ircd #x1B[2m2026-03-05T21:52:10.071848Z#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 1772747530.072 sable_ircd #x1B[2m2026-03-05T21:52:10.071901Z#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"PRIVMSG #chan :hi again from baz" 1772747530.172 baz -> S: PING synchronize367.508310502 1772747530.172 sable_ircd #x1B[2m2026-03-05T21:52:10.172143Z#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 1772747530.172 sable_ircd #x1B[2m2026-03-05T21:52:10.172202Z#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 synchronize367.508310502" 1772747531.173 baz: waiting… 1772747531.178 sable_ircd #x1B[2m2026-03-05T21:52:11.177816Z#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(817514859418619913)), timestamp: 1772747531, clock: EventClock(1 => 817514850769965064), target: Message(MessageId(Uuid7(019cbffc-a3a9-7090-8ed4-670293a32515))), details: NewMessage(NewMessage { source: UserId(Snowflake(817514834105995267)), target: Channel(ChannelId(Snowflake(817514817005817858))), message_type: Privmsg, text: "hi again from baz" }) }; event clock=EventClock(1 => 817514850769965064) my clock=EventClock(1 => 817514850769965064) 1772747531.178 sable_ircd #x1B[2m2026-03-05T21:52:11.178025Z#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 1772747531.178 sable_ircd #x1B[2m2026-03-05T21:52:11.178024Z#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 1772747531.178 sable_ircd #x1B[2m2026-03-05T21:52:11.178317Z#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(817514859418619913)), timestamp: 1772747531, change: NewMessage(NewMessage { message: MessageId(Uuid7(019cbffc-a3a9-7090-8ed4-670293a32515)), source: User(HistoricUserId(UserId(Snowflake(817514834105995267)), 2)), target: Channel(ChannelId(Snowflake(817514817005817858))) }), users_to_notify: [UserId(Snowflake(817514834105995267)), UserId(Snowflake(817514813633597440))] }) 1772747531.178 sable_ircd #x1B[2m2026-03-05T21:52:11.178397Z#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(817514859418619913)), timestamp: 1772747531, change: NewMessage(NewMessage { message: MessageId(Uuid7(019cbffc-a3a9-7090-8ed4-670293a32515)), source: User(HistoricUserId(UserId(Snowflake(817514834105995267)), 2)), target: Channel(ChannelId(Snowflake(817514817005817858))) }), users_to_notify: [UserId(Snowflake(817514834105995267)), UserId(Snowflake(817514813633597440))] } 1772747531.179 sable_ircd #x1B[2m2026-03-05T21:52:11.178515Z#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 PRIVMSG #chan :hi again from baz 1772747531.179 sable_ircd #x1B[2m2026-03-05T21:52:11.178617Z#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(817514859418619913)), timestamp: 1772747531, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747531.179 sable_ircd #x1B[2m2026-03-05T21:52:11.178661Z#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(817514859418619913)), timestamp: 1772747531, change: EventComplete(EventComplete), users_to_notify: [] } 1772747532.174 baz: waiting… 1772747532.184 sable_ircd #x1B[2m2026-03-05T21:52:12.183292Z#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 :synchronize367.508310502 1772747532.184 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize367.508310502 1772747532.284 chanop -> S: PING synchronize369.620685392 1772747532.284 S -> chanop: :baz!username@localhost PRIVMSG #chan :hi again from baz 1772747532.285 sable_ircd #x1B[2m2026-03-05T21:52:12.284510Z#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 1772747532.285 sable_ircd #x1B[2m2026-03-05T21:52:12.284575Z#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 synchronize369.620685392" 1772747532.285 sable_ircd #x1B[2m2026-03-05T21:52:12.284706Z#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 :synchronize369.620685392 1772747532.285 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize369.620685392 1772747532.289 chanop: disconnects from server. 1772747532.289 baz: disconnects from server.