--------------------------------- Captured Out --------------------------------- ---- new test ---- 1771275934.247 sable_ircd uid=1001 1771275934.251 sable_ircd #x1B[2m2026-02-16T21:05:34.250626Z#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(811342534541316096)), timestamp: 1771275934, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1771275934, name: ServerName("My.Little.Server"), ts: 1771275934, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1771275934.251 sable_ircd #x1B[2m2026-02-16T21:05:34.250744Z#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 1771275934.251 sable_ircd #x1B[2m2026-02-16T21:05:34.250848Z#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(811342534541316097)), timestamp: 1771275934, clock: EventClock(1 => 811342534541316096), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1771275934 }) }; event clock=EventClock(1 => 811342534541316096) my clock=EventClock(1 => 811342534541316096) 1771275934.251 sable_ircd #x1B[2m2026-02-16T21:05:34.250902Z#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 1771275934.251 sable_ircd #x1B[2m2026-02-16T21:05:34.251220Z#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(811342534541316096)), timestamp: 1771275934, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1771275934, name: ServerName("My.Little.Server"), ts: 1771275934, 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 1771275934.252 sable_ircd #x1B[2m2026-02-16T21:05:34.251449Z#x1B[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(811342534541316096)), timestamp: 1771275934, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1771275934.252 sable_ircd #x1B[2m2026-02-16T21:05:34.251494Z#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(811342534541316096)), timestamp: 1771275934, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1771275934.252 sable_ircd #x1B[2m2026-02-16T21:05:34.251532Z#x1B[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(811342534541316096)), timestamp: 1771275934, change: EventComplete(EventComplete), users_to_notify: [] }) 1771275934.252 sable_ircd #x1B[2m2026-02-16T21:05:34.251581Z#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(811342534541316096)), timestamp: 1771275934, change: EventComplete(EventComplete), users_to_notify: [] } 1771275934.252 sable_ircd #x1B[2m2026-02-16T21:05:34.251623Z#x1B[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(811342534541316097)), timestamp: 1771275934, change: EventComplete(EventComplete), users_to_notify: [] }) 1771275934.252 sable_ircd #x1B[2m2026-02-16T21:05:34.251643Z#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(811342534541316097)), timestamp: 1771275934, change: EventComplete(EventComplete), users_to_notify: [] } 1771275934.252 sable_ircd #x1B[2m2026-02-16T21:05:34.251966Z#x1B[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 1771275934.343 sable_ircd #x1B[2m2026-02-16T21:05:34.342849Z#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 } 1771275934.343 sable_ircd #x1B[2m2026-02-16T21:05:34.343014Z#x1B[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 1771275934.343 sable_ircd #x1B[2m2026-02-16T21:05:34.343080Z#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 1771275934.343 sable_ircd #x1B[2m2026-02-16T21:05:34.343167Z#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 1771275934.343 sable_ircd #x1B[2m2026-02-16T21:05:34.343353Z#x1B[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 1771275934.343 sable_ircd #x1B[2m2026-02-16T21:05:34.343429Z#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" 1771275934.344 sable_ircd #x1B[2m2026-02-16T21:05:34.343575Z#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 1771275934.344 sable_ircd #x1B[2m2026-02-16T21:05:34.343701Z#x1B[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)) 1771275934.344 sable_ircd #x1B[2m2026-02-16T21:05:34.343741Z#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) 1771275934.344 sable_ircd #x1B[2m2026-02-16T21:05:34.344222Z#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 1771275934.344 sable_ircd #x1B[2m2026-02-16T21:05:34.344296Z#x1B[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 1771275934.344 sable_ircd #x1B[2m2026-02-16T21:05:34.344418Z#x1B[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 1771275934.364 1: connects to server. 1771275934.364 1 -> S: CAP LS 302 1771275934.364 sable_ircd #x1B[2m2026-02-16T21:05:34.364153Z#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 } 1771275934.364 sable_ircd #x1B[2m2026-02-16T21:05:34.364255Z#x1B[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 1771275934.364 sable_ircd #x1B[2m2026-02-16T21:05:34.364324Z#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 1771275934.364 sable_ircd #x1B[2m2026-02-16T21:05:34.364374Z#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 1771275934.365 sable_ircd #x1B[2m2026-02-16T21:05:34.364505Z#x1B[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 1771275934.365 sable_ircd #x1B[2m2026-02-16T21:05:34.364613Z#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"CAP LS 302" 1771275934.365 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1771275934.365 sable_ircd #x1B[2m2026-02-16T21:05:34.364753Z#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 CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1771275934.365 S -> 1: :My.Little.Server CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1771275934.365 1 -> S: CAP REQ :multi-prefix 1771275934.365 sable_ircd #x1B[2m2026-02-16T21:05:34.365248Z#x1B[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 1771275934.365 sable_ircd #x1B[2m2026-02-16T21:05:34.365298Z#x1B[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")) 1771275934.365 sable_ircd #x1B[2m2026-02-16T21:05:34.365338Z#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 1771275934.365 sable_ircd #x1B[2m2026-02-16T21:05:34.365364Z#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: 672, tv_nsec: 464815063 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1771275934.366 sable_ircd #x1B[2m2026-02-16T21:05:34.365589Z#x1B[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 1771275934.366 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost1771275934.366 sable_ircd #x1B[2m2026-02-16T21:05:34.365640Z#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"CAP REQ :multi-prefix" 1771275934.366 sable_ircd #x1B[2m2026-02-16T21:05:34.365786Z#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 CAP * ACK :multi-prefix 1771275934.366 sable_ircd #x1B[2m2026-02-16T21:05:34.365835Z#x1B[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[0mUpdateConnectionCaps(ConnectionId(ListenerId(0), 2), ClientCapabilitySet(512)) 1771275934.407 S -> 1: :My.Little.Server CAP * ACK :multi-prefix 1771275934.407 1 -> S: NICK foo 1771275934.407 1 -> S: USER username * * :Realname 1771275934.407 1 -> S: CAP END 1771275934.407 sable_ircd #x1B[2m2026-02-16T21:05:34.407000Z#x1B[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 1771275934.407 sable_ircd #x1B[2m2026-02-16T21:05:34.407038Z#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 foo" 1771275934.407 sable_ircd #x1B[2m2026-02-16T21:05:34.407127Z#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: 672, tv_nsec: 464815063 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("foo")), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1771275934.407 sable_ircd #x1B[2m2026-02-16T21:05:34.407184Z#x1B[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 1771275934.407 sable_ircd #x1B[2m2026-02-16T21:05:34.407228Z#x1B[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 1771275934.407 sable_ircd #x1B[2m2026-02-16T21:05:34.407259Z#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" 1771275934.407 sable_ircd #x1B[2m2026-02-16T21:05:34.407324Z#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: 672, tv_nsec: 464815063 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("foo")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1771275934.407 sable_ircd #x1B[2m2026-02-16T21:05:34.407387Z#x1B[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 1771275934.407 sable_ircd #x1B[2m2026-02-16T21:05:34.407418Z#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"CAP END" 1771275935.160 sable_ircd #x1B[2m2026-02-16T21:05:35.160182Z#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::complete_progress #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 672, tv_nsec: 464815063 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("foo")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mflag#x1B[0m#x1B[2m=#x1B[0mCapNegotiation #x1B[3mresult#x1B[0m#x1B[2m=#x1B[0mtrue 1771275935.160 sable_ircd #x1B[2m2026-02-16T21:05:35.160296Z#x1B[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)) 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.160591Z#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(811342538358132738)), timestamp: 1771275935, clock: EventClock(1 => 811342534541316097), target: User(UserId(Snowflake(811342538358132736))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(811342538358132737)), NewUserConnection { user: UserId(Snowflake(811342538358132736)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771275935 })) }) }; event clock=EventClock(1 => 811342534541316097) my clock=EventClock(1 => 811342534541316097) 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.160689Z#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 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.161016Z#x1B[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(811342538358132738)), timestamp: 1771275935, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(811342538358132736)), 1) }), users_to_notify: [] }) 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.161065Z#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(811342538358132738)), timestamp: 1771275935, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(811342538358132736)), 1) }), users_to_notify: [] } 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.161123Z#x1B[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(811342538358132738)), timestamp: 1771275935, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(811342538358132736)), 2), connection: UserConnectionId(Snowflake(811342538358132737)) }), users_to_notify: [] }) 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.161152Z#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(811342538358132738)), timestamp: 1771275935, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(811342538358132736)), 2), connection: UserConnectionId(Snowflake(811342538358132737)) }), users_to_notify: [] } 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.161204Z#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 foo :Welcome to the test Internet Relay Chat network, foo 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.161253Z#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 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.161306Z#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 foo :This server was created 2026-02-16 21:05:35.161289394 UTC 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.161346Z#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 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1771275935.161 sable_ircd #x1B[2m2026-02-16T21:05:35.161421Z#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 foo 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 1771275935.162 sable_ircd #x1B[2m2026-02-16T21:05:35.161472Z#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 foo :MOTD File is missing 1771275935.162 sable_ircd #x1B[2m2026-02-16T21:05:35.161530Z#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): :foo!username@localhost MODE foo + 1771275935.162 sable_ircd #x1B[2m2026-02-16T21:05:35.161592Z#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 foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1771275935.162 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo 1771275935.162 1 -> S: PING foo 1771275935.162 sable_ircd #x1B[2m2026-02-16T21:05:35.161640Z#x1B[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(811342538358132738)), timestamp: 1771275935, change: EventComplete(EventComplete), users_to_notify: [] }) 1771275935.162 sable_ircd #x1B[2m2026-02-16T21:05:35.161677Z#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(811342538358132738)), timestamp: 1771275935, change: EventComplete(EventComplete), users_to_notify: [] } 1771275935.162 sable_ircd #x1B[2m2026-02-16T21:05:35.162043Z#x1B[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 1771275935.162 sable_ircd #x1B[2m2026-02-16T21:05:35.162094Z#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" 1771275935.262 1 -> S: PING synchronize673.362382552 1771275935.262 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1771275935.262 S -> 1: :My.Little.Server 003 foo :This server was created 2026-02-16 21:05:35.161289394 UTC 1771275935.262 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1771275935.262 S -> 1: :My.Little.Server 005 foo 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 1771275935.262 S -> 1: :My.Little.Server 422 foo :MOTD File is missing 1771275935.262 S -> 1: :foo!username@localhost MODE foo + 1771275935.262 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1771275935.262 sable_ircd #x1B[2m2026-02-16T21:05:35.262305Z#x1B[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 1771275935.262 sable_ircd #x1B[2m2026-02-16T21:05:35.262358Z#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 synchronize673.362382552" 1771275935.823 sable_history #x1B[2m2027-02-16T21:44:04.055234Z#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(943623793505673260)), timestamp: 1802814244, clock: EventClock(1 => 943613421427888129, 50 => 943623541847433259), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1802814244 }) }; event clock=EventClock(1 => 943613421427888129, 50 => 943623541847433259) my clock=EventClock(1 => 943613421427888129, 50 => 943623541847433259) 1771275935.823 sable_history #x1B[2m2027-02-16T21:44:04.057098Z#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 1771275936.015 sable_ircd #x1B[2m2026-02-16T21:05:36.014940Z#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 1771275936.015 S -> 1: :My.Little.Server PONG My.Little.Server :foo 1771275936.232 sable_history #x1B[2m2027-02-16T21:43:55.421754Z#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(943623757296246828)), timestamp: 1802814235, clock: EventClock(1 => 943613425731244033, 50 => 943623505633812523), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1802814235 }) }; event clock=EventClock(1 => 943613425731244033, 50 => 943623505633812523) my clock=EventClock(1 => 943613425731244033, 50 => 943623505633812523) 1771275936.232 sable_history #x1B[2m2027-02-16T21:43:55.423668Z#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 1771275936.645 sable_history #x1B[2m2027-02-16T21:43:55.351384Z#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(943623756998451245)), timestamp: 1802814235, clock: EventClock(1 => 943613507641806863, 50 => 943623505340211244, 99 => 943613497584267268), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1802814235 }) }; event clock=EventClock(1 => 943613507641806863, 50 => 943623505340211244, 99 => 943613497584267268) my clock=EventClock(1 => 943613507641806863, 50 => 943623505340211244, 99 => 943613497584267268) 1771275936.645 sable_history #x1B[2m2027-02-16T21:43:55.353337Z#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 1771275937.016 1: waiting… 1771275937.020 sable_ircd #x1B[2m2026-02-16T21:05:37.020329Z#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 :synchronize673.362382552 1771275937.021 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize673.362382552 1771275937.722 1 -> S: JOIN #chan 1771275937.722 sable_ircd #x1B[2m2026-02-16T21:05:37.721887Z#x1B[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 1771275937.722 sable_ircd #x1B[2m2026-02-16T21:05:37.721947Z#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" 1771275937.822 1 -> S: PING synchronize675.922157339 1771275937.822 sable_ircd #x1B[2m2026-02-16T21:05:37.822120Z#x1B[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 1771275937.822 sable_ircd #x1B[2m2026-02-16T21:05:37.822189Z#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 synchronize675.922157339" 1771275938.073 sable_ircd #x1B[2m2026-02-16T21:05:38.072985Z#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(811342550571945987)), timestamp: 1771275938, clock: EventClock(1 => 811342538358132738), target: Channel(ChannelId(Snowflake(811342550571945986))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 811342538358132738) my clock=EventClock(1 => 811342538358132738) 1771275938.073 sable_ircd #x1B[2m2026-02-16T21:05:38.073165Z#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 1771275938.073 sable_ircd #x1B[2m2026-02-16T21:05:38.073232Z#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(811342550576140292)), timestamp: 1771275938, clock: EventClock(1 => 811342550571945987), target: Membership(MembershipId(UserId(Snowflake(811342538358132736)), ChannelId(Snowflake(811342550571945986)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(811342550571945986)), user: UserId(Snowflake(811342538358132736)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 811342550571945987) my clock=EventClock(1 => 811342550571945987) 1771275938.073 sable_ircd #x1B[2m2026-02-16T21:05:38.073373Z#x1B[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 1771275938.073 sable_ircd #x1B[2m2026-02-16T21:05:38.073404Z#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 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.073868Z#x1B[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(811342550571945987)), timestamp: 1771275938, change: EventComplete(EventComplete), users_to_notify: [] }) 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.073908Z#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(811342550571945987)), timestamp: 1771275938, change: EventComplete(EventComplete), users_to_notify: [] } 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.073960Z#x1B[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(811342550576140292)), timestamp: 1771275938, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(811342538358132736)), ChannelId(Snowflake(811342550571945986))), user: HistoricUserId(UserId(Snowflake(811342538358132736)), 2) }), users_to_notify: [UserId(Snowflake(811342538358132736))] }) 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.074002Z#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(811342550576140292)), timestamp: 1771275938, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(811342538358132736)), ChannelId(Snowflake(811342550571945986))), user: HistoricUserId(UserId(Snowflake(811342538358132736)), 2) }), users_to_notify: [UserId(Snowflake(811342538358132736))] } 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.074073Z#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): :foo!username@localhost JOIN #chan 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.074131Z#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): :foo!username@localhost MODE #chan +o foo 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.074186Z#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 foo = #chan :@foo 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.074229Z#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 foo #chan :End of names list 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.074273Z#x1B[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(811342550576140292)), timestamp: 1771275938, change: EventComplete(EventComplete), users_to_notify: [] }) 1771275938.074 sable_ircd #x1B[2m2026-02-16T21:05:38.074302Z#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(811342550576140292)), timestamp: 1771275938, change: EventComplete(EventComplete), users_to_notify: [] } 1771275938.075 S -> 1: :foo!username@localhost JOIN #chan 1771275938.075 S -> 1: :foo!username@localhost MODE #chan +o foo 1771275938.075 S -> 1: :My.Little.Server 353 foo = #chan :@foo 1771275938.075 S -> 1: :My.Little.Server 366 foo #chan :End of names list 1771275939.076 1: waiting… 1771275939.078 sable_ircd #x1B[2m2026-02-16T21:05:39.077950Z#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 :synchronize675.922157339 1771275939.078 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize675.922157339 1771275939.078 1 -> S: MODE #chan +v foo 1771275939.079 sable_ircd #x1B[2m2026-02-16T21:05:39.078654Z#x1B[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 1771275939.079 sable_ircd #x1B[2m2026-02-16T21:05:39.078745Z#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 foo" 1771275939.179 1 -> S: PING synchronize677.278926431 1771275939.179 sable_ircd #x1B[2m2026-02-16T21:05:39.178818Z#x1B[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 1771275939.179 sable_ircd #x1B[2m2026-02-16T21:05:39.178880Z#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 synchronize677.278926431" 1771275939.823 sable_history #x1B[2m2027-02-16T21:45:04.055051Z#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(943624045163913261)), timestamp: 1802814304, clock: EventClock(1 => 943613421427888129, 50 => 943623793505673260), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1802814304 }) }; event clock=EventClock(1 => 943613421427888129, 50 => 943623793505673260) my clock=EventClock(1 => 943613421427888129, 50 => 943623793505673260) 1771275939.823 sable_history #x1B[2m2027-02-16T21:45:04.056910Z#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 1771275940.180 1: waiting… 1771275940.183 sable_ircd #x1B[2m2026-02-16T21:05:40.183210Z#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(811342559426121733)), timestamp: 1771275940, clock: EventClock(1 => 811342550576140292), target: Membership(MembershipId(UserId(Snowflake(811342538358132736)), ChannelId(Snowflake(811342550571945986)))), details: MembershipFlagChange(MembershipFlagChange { changed_by: User(UserId(Snowflake(811342538358132736))), added: MembershipFlagSet(2), removed: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 811342550576140292) my clock=EventClock(1 => 811342550576140292) 1771275940.183 sable_ircd #x1B[2m2026-02-16T21:05:40.183405Z#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 1771275940.183 sable_ircd #x1B[2m2026-02-16T21:05:40.183416Z#x1B[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 1771275940.184 sable_ircd #x1B[2m2026-02-16T21:05:40.183728Z#x1B[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(811342559426121733)), timestamp: 1771275940, change: MembershipFlagChange(MembershipFlagChange { membership: MembershipId(UserId(Snowflake(811342538358132736)), ChannelId(Snowflake(811342550571945986))), user: HistoricUserId(UserId(Snowflake(811342538358132736)), 2), added: MembershipFlagSet(2), removed: MembershipFlagSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(811342538358132736)), 2)) }), users_to_notify: [UserId(Snowflake(811342538358132736))] }) 1771275940.184 sable_ircd #x1B[2m2026-02-16T21:05:40.183781Z#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(811342559426121733)), timestamp: 1771275940, change: MembershipFlagChange(MembershipFlagChange { membership: MembershipId(UserId(Snowflake(811342538358132736)), ChannelId(Snowflake(811342550571945986))), user: HistoricUserId(UserId(Snowflake(811342538358132736)), 2), added: MembershipFlagSet(2), removed: MembershipFlagSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(811342538358132736)), 2)) }), users_to_notify: [UserId(Snowflake(811342538358132736))] } 1771275940.184 sable_ircd #x1B[2m2026-02-16T21:05:40.183865Z#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): :foo!username@localhost MODE #chan +v foo 1771275940.184 sable_ircd #x1B[2m2026-02-16T21:05:40.183933Z#x1B[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(811342559426121733)), timestamp: 1771275940, change: EventComplete(EventComplete), users_to_notify: [] }) 1771275940.184 sable_ircd #x1B[2m2026-02-16T21:05:40.183966Z#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(811342559426121733)), timestamp: 1771275940, change: EventComplete(EventComplete), users_to_notify: [] } 1771275940.184 S -> 1: :foo!username@localhost MODE #chan +v foo 1771275940.232 sable_history #x1B[2m2027-02-16T21:44:55.420927Z#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(943624008950292525)), timestamp: 1802814295, clock: EventClock(1 => 943613425731244033, 50 => 943623757296246828), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1802814295 }) }; event clock=EventClock(1 => 943613425731244033, 50 => 943623757296246828) my clock=EventClock(1 => 943613425731244033, 50 => 943623757296246828) 1771275940.232 sable_history #x1B[2m2027-02-16T21:44:55.422733Z#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 1771275940.645 sable_history #x1B[2m2027-02-16T21:44:55.350559Z#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(943624008656691246)), timestamp: 1802814295, clock: EventClock(1 => 943613507641806863, 50 => 943623756998451245, 99 => 943613497584267268), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1802814295 }) }; event clock=EventClock(1 => 943613507641806863, 50 => 943623756998451245, 99 => 943613497584267268) my clock=EventClock(1 => 943613507641806863, 50 => 943623756998451245, 99 => 943613497584267268) 1771275940.645 sable_history #x1B[2m2027-02-16T21:44:55.351710Z#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 1771275941.185 1: waiting… 1771275941.190 sable_ircd #x1B[2m2026-02-16T21:05:41.190196Z#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 :synchronize677.278926431 1771275941.190 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize677.278926431 1771275941.191 1 -> S: NAMES #chan 1771275941.191 sable_ircd #x1B[2m2026-02-16T21:05:41.190814Z#x1B[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 1771275941.191 sable_ircd #x1B[2m2026-02-16T21:05:41.190866Z#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"NAMES #chan" 1771275941.291 1 -> S: PING synchronize679.391152661 1771275941.291 sable_ircd #x1B[2m2026-02-16T21:05:41.291095Z#x1B[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 1771275941.291 sable_ircd #x1B[2m2026-02-16T21:05:41.291155Z#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 synchronize679.391152661" 1771275942.044 sable_ircd #x1B[2m2026-02-16T21:05:42.043847Z#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 foo = #chan :@+foo 1771275942.044 sable_ircd #x1B[2m2026-02-16T21:05:42.043911Z#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 foo #chan :End of names list 1771275942.044 S -> 1: :My.Little.Server 353 foo = #chan :@+foo 1771275942.085 S -> 1: :My.Little.Server 366 foo #chan :End of names list 1771275943.049 sable_ircd #x1B[2m2026-02-16T21:05:43.049404Z#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 :synchronize679.391152661 1771275943.050 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize679.391152661 1771275943.150 1 -> S: PING synchronize681.250444083 1771275943.150 sable_ircd #x1B[2m2026-02-16T21:05:43.150390Z#x1B[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 1771275943.150 sable_ircd #x1B[2m2026-02-16T21:05:43.150454Z#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 synchronize681.250444083" 1771275943.823 sable_history #x1B[2m2027-02-16T21:46:04.055064Z#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(943624296822153262)), timestamp: 1802814364, clock: EventClock(1 => 943613421427888129, 50 => 943624045163913261), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1802814364 }) }; event clock=EventClock(1 => 943613421427888129, 50 => 943624045163913261) my clock=EventClock(1 => 943613421427888129, 50 => 943624045163913261) 1771275943.823 sable_history #x1B[2m2027-02-16T21:46:04.057026Z#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 1771275944.151 1: waiting… 1771275944.155 sable_ircd #x1B[2m2026-02-16T21:05:44.154801Z#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 :synchronize681.250444083 1771275944.155 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize681.250444083 1771275944.155 1 -> S: WHO #chan 1771275944.155 sable_ircd #x1B[2m2026-02-16T21:05:44.155453Z#x1B[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 1771275944.156 sable_ircd #x1B[2m2026-02-16T21:05:44.155495Z#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"WHO #chan" 1771275944.232 sable_history #x1B[2m2027-02-16T21:45:55.422080Z#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(943624260612726830)), timestamp: 1802814355, clock: EventClock(1 => 943613425731244033, 50 => 943624008950292525), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1802814355 }) }; event clock=EventClock(1 => 943613425731244033, 50 => 943624008950292525) my clock=EventClock(1 => 943613425731244033, 50 => 943624008950292525) 1771275944.232 sable_history #x1B[2m2027-02-16T21:45:55.423678Z#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 1771275944.255 1 -> S: PING synchronize682.35578082 1771275944.256 sable_ircd #x1B[2m2026-02-16T21:05:44.255796Z#x1B[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 1771275944.256 sable_ircd #x1B[2m2026-02-16T21:05:44.255859Z#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 synchronize682.35578082" 1771275944.645 sable_history #x1B[2m2027-02-16T21:45:55.351611Z#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(943624260314931247)), timestamp: 1802814355, clock: EventClock(1 => 943613507641806863, 50 => 943624008656691246, 99 => 943613497584267268), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1802814355 }) }; event clock=EventClock(1 => 943613507641806863, 50 => 943624008656691246, 99 => 943613497584267268) my clock=EventClock(1 => 943613507641806863, 50 => 943624008656691246, 99 => 943613497584267268) 1771275944.645 sable_history #x1B[2m2027-02-16T21:45:55.353710Z#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 1771275945.010 sable_ircd #x1B[2m2026-02-16T21:05:45.009738Z#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 352 foo #chan username localhost * foo H@+ :0 Realname 1771275945.010 sable_ircd #x1B[2m2026-02-16T21:05:45.009799Z#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 315 foo #chan :End of /WHO list 1771275945.010 S -> 1: :My.Little.Server 352 foo #chan username localhost * foo H@+ :0 Realname 1771275945.051 S -> 1: :My.Little.Server 315 foo #chan :End of /WHO list 1771275946.016 sable_ircd #x1B[2m2026-02-16T21:05:46.016301Z#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 :synchronize682.35578082 1771275946.017 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize682.35578082 1771275946.020 1: disconnects from server.