--------------------------------- Captured Out --------------------------------- ---- new test ---- 1788127699.348 sable_ircd uid=1001 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.350363Z#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(882023960307306496)), timestamp: 1788127699, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127699, name: ServerName("My.Little.Server"), ts: 1788127699, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.350473Z#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 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.350604Z#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(882023960307306496)), timestamp: 1788127699, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127699, name: ServerName("My.Little.Server"), ts: 1788127699, 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 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.350729Z#x1B[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(882023960307306496)), timestamp: 1788127699, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.350757Z#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(882023960307306496)), timestamp: 1788127699, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.350802Z#x1B[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(882023960307306496)), timestamp: 1788127699, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.350818Z#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(882023960307306496)), timestamp: 1788127699, change: EventComplete(EventComplete), users_to_notify: [] } 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.351116Z#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(882023960311500801)), timestamp: 1788127699, clock: EventClock(1 => 882023960307306496), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127699 }) }; event clock=EventClock(1 => 882023960307306496) my clock=EventClock(1 => 882023960307306496) 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.351149Z#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 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.351258Z#x1B[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(882023960311500801)), timestamp: 1788127699, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127699.351 sable_ircd #x1B[2m2026-08-30T22:08:19.351273Z#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(882023960311500801)), timestamp: 1788127699, change: EventComplete(EventComplete), users_to_notify: [] } 1788127699.352 sable_ircd #x1B[2m2026-08-30T22:08:19.352430Z#x1B[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 1788127699.444 sable_ircd #x1B[2m2026-08-30T22:08:19.444407Z#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 } 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.444533Z#x1B[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 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.444574Z#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 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.444629Z#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 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.444742Z#x1B[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 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.444789Z#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" 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.444871Z#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 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.444939Z#x1B[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)) 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.444965Z#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) 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.445367Z#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 1788127699.445 sable_ircd #x1B[2m2026-08-30T22:08:19.445428Z#x1B[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 1788127699.446 sable_ircd #x1B[2m2026-08-30T22:08:19.445509Z#x1B[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 1788127699.465 1: connects to server. 1788127699.465 1 -> S: NICK foo 1788127699.465 1 -> S: USER username * * :Realname 1788127699.465 sable_ircd #x1B[2m2026-08-30T22:08:19.465376Z#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 } 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465509Z#x1B[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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465539Z#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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465575Z#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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465662Z#x1B[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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465695Z#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" 1788127699.466 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465811Z#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: 345, tv_nsec: 587181427 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("foo")), 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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465863Z#x1B[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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465889Z#x1B[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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465918Z#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" 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.465976Z#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: 345, tv_nsec: 587181427 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("foo")), 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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.466327Z#x1B[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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.466353Z#x1B[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")) 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.466376Z#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 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.466411Z#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: 345, tv_nsec: 587181427 }, 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[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127699.466 sable_ircd #x1B[2m2026-08-30T22:08:19.466445Z#x1B[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)) 1788127699.467 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.466649Z#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(882023960793845762)), timestamp: 1788127699, clock: EventClock(1 => 882023960311500801), target: User(UserId(Snowflake(882023960793845760))), 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(882023960793845761)), NewUserConnection { user: UserId(Snowflake(882023960793845760)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127699 })) }) }; event clock=EventClock(1 => 882023960311500801) my clock=EventClock(1 => 882023960311500801) 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.466732Z#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 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.466942Z#x1B[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(882023960793845762)), timestamp: 1788127699, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882023960793845760)), 1) }), users_to_notify: [] }) 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.466971Z#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(882023960793845762)), timestamp: 1788127699, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882023960793845760)), 1) }), users_to_notify: [] } 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467003Z#x1B[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(882023960793845762)), timestamp: 1788127699, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882023960793845760)), 2), connection: UserConnectionId(Snowflake(882023960793845761)) }), users_to_notify: [] }) 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467016Z#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(882023960793845762)), timestamp: 1788127699, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882023960793845760)), 2), connection: UserConnectionId(Snowflake(882023960793845761)) }), users_to_notify: [] } 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467047Z#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 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467062Z#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 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467076Z#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-08-30 22:08:19.467070552 UTC 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467086Z#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 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467107Z#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 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467117Z#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 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467129Z#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 + 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467139Z#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. 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467161Z#x1B[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(882023960793845762)), timestamp: 1788127699, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127699.467 sable_ircd #x1B[2m2026-08-30T22:08:19.467173Z#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(882023960793845762)), timestamp: 1788127699, change: EventComplete(EventComplete), users_to_notify: [] } 1788127699.467 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo 1788127699.467 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127699.467 1 -> S: PING foo 1788127699.468 sable_ircd #x1B[2m2026-08-30T22:08:19.467616Z#x1B[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 1788127699.468 sable_ircd #x1B[2m2026-08-30T22:08:19.467645Z#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" 1788127699.468 sable_ircd #x1B[2m2026-08-30T22:08:19.467693Z#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 1788127699.632 sable_history #x1B[2m2027-08-30T22:41:02.100664Z#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(1014303763617488935)), timestamp: 1819665662, clock: EventClock(1 => 1014295448346693654, 50 => 1014303511959248934, 99 => 1014295451547348996), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665662 }) }; event clock=EventClock(1 => 1014295448346693654, 50 => 1014303511959248934, 99 => 1014295451547348996) my clock=EventClock(1 => 1014295448346693654, 50 => 1014303511959248934, 99 => 1014295451547348996) 1788127699.632 sable_history #x1B[2m2027-08-30T22:41:02.102068Z#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 1788127699.649 sable_history #x1B[2m2027-08-30T22:29:50.148065Z#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(1014300945246527515)), timestamp: 1819664990, clock: EventClock(1 => 1014295224354082831, 50 => 1014300693588287514, 99 => 1014295214413983748), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819664990 }) }; event clock=EventClock(1 => 1014295224354082831, 50 => 1014300693588287514, 99 => 1014295214413983748) my clock=EventClock(1 => 1014295224354082831, 50 => 1014300693588287514, 99 => 1014295214413983748) 1788127699.649 sable_history #x1B[2m2027-08-30T22:29:50.149213Z#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 1788127699.668 1 -> S: PING synchronize345.789279472 1788127699.668 S -> 1: :My.Little.Server 003 foo :This server was created 2026-08-30 22:08:19.467070552 UTC 1788127699.668 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127699.668 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 1788127699.668 S -> 1: :My.Little.Server 422 foo :MOTD File is missing 1788127699.668 S -> 1: :foo!username@localhost MODE foo + 1788127699.668 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127699.668 S -> 1: :My.Little.Server PONG My.Little.Server :foo 1788127699.668 sable_ircd #x1B[2m2026-08-30T22:08:19.668195Z#x1B[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 1788127699.668 sable_ircd #x1B[2m2026-08-30T22:08:19.668256Z#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 synchronize345.789279472" 1788127699.668 sable_ircd #x1B[2m2026-08-30T22:08:19.668395Z#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 :synchronize345.789279472 1788127699.669 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize345.789279472 1788127700.269 1 -> S: JOIN #chan 1788127700.270 sable_ircd #x1B[2m2026-08-30T22:08:20.269743Z#x1B[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 1788127700.270 sable_ircd #x1B[2m2026-08-30T22:08:20.269791Z#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" 1788127700.270 sable_ircd #x1B[2m2026-08-30T22:08:20.270057Z#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(882023964166066179)), timestamp: 1788127700, clock: EventClock(1 => 882023960793845762), target: Channel(ChannelId(Snowflake(882023964161871874))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 882023960793845762) my clock=EventClock(1 => 882023960793845762) 1788127700.270 sable_ircd #x1B[2m2026-08-30T22:08:20.270198Z#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 1788127700.270 sable_ircd #x1B[2m2026-08-30T22:08:20.270259Z#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(882023964166066180)), timestamp: 1788127700, clock: EventClock(1 => 882023964166066179), target: Membership(MembershipId(UserId(Snowflake(882023960793845760)), ChannelId(Snowflake(882023964161871874)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882023964161871874)), user: UserId(Snowflake(882023960793845760)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 882023964166066179) my clock=EventClock(1 => 882023964166066179) 1788127700.270 sable_ircd #x1B[2m2026-08-30T22:08:20.270340Z#x1B[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 1788127700.270 sable_ircd #x1B[2m2026-08-30T22:08:20.270355Z#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 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270536Z#x1B[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(882023964166066179)), timestamp: 1788127700, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270564Z#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(882023964166066179)), timestamp: 1788127700, change: EventComplete(EventComplete), users_to_notify: [] } 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270603Z#x1B[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(882023964166066180)), timestamp: 1788127700, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882023960793845760)), ChannelId(Snowflake(882023964161871874))), user: HistoricUserId(UserId(Snowflake(882023960793845760)), 2) }), users_to_notify: [UserId(Snowflake(882023960793845760))] }) 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270625Z#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(882023964166066180)), timestamp: 1788127700, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882023960793845760)), ChannelId(Snowflake(882023964161871874))), user: HistoricUserId(UserId(Snowflake(882023960793845760)), 2) }), users_to_notify: [UserId(Snowflake(882023960793845760))] } 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270675Z#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 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270708Z#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 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270747Z#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 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270765Z#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 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270799Z#x1B[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(882023964166066180)), timestamp: 1788127700, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127700.271 sable_ircd #x1B[2m2026-08-30T22:08:20.270817Z#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(882023964166066180)), timestamp: 1788127700, change: EventComplete(EventComplete), users_to_notify: [] } 1788127700.370 1 -> S: PING synchronize346.491119689 1788127700.370 S -> 1: :foo!username@localhost JOIN #chan 1788127700.370 S -> 1: :foo!username@localhost MODE #chan +o foo 1788127700.370 S -> 1: :My.Little.Server 353 foo = #chan :@foo 1788127700.370 S -> 1: :My.Little.Server 366 foo #chan :End of names list 1788127700.370 sable_ircd #x1B[2m2026-08-30T22:08:20.369980Z#x1B[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 1788127700.370 sable_ircd #x1B[2m2026-08-30T22:08:20.370056Z#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 synchronize346.491119689" 1788127700.509 sable_history #x1B[2m2027-08-30T22:43:51.009548Z#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(1014304472073183274)), timestamp: 1819665831, clock: EventClock(1 => 1014295401760559126, 50 => 1014304220414943273, 99 => 1014295404927660036), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665831 }) }; event clock=EventClock(1 => 1014295401760559126, 50 => 1014304220414943273, 99 => 1014295404927660036) my clock=EventClock(1 => 1014295401760559126, 50 => 1014304220414943273, 99 => 1014295404927660036) 1788127700.509 sable_history #x1B[2m2027-08-30T22:43:51.011064Z#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 1788127700.899 sable_history #x1B[2m2027-08-30T22:33:35.382847Z#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(1014301889950588959)), timestamp: 1819665215, clock: EventClock(1 => 1014295842380582945, 50 => 1014301638292348958, 99 => 1014295842997547013), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665215 }) }; event clock=EventClock(1 => 1014295842380582945, 50 => 1014301638292348958, 99 => 1014295842997547013) my clock=EventClock(1 => 1014295842380582945, 50 => 1014301638292348958, 99 => 1014295842997547013) 1788127700.899 sable_history #x1B[2m2027-08-30T22:33:35.384374Z#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 1788127701.123 sable_ircd #x1B[2m2026-08-30T22:08:21.122721Z#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 :synchronize346.491119689 1788127701.123 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize346.491119689 1788127701.123 2: connects to server. 1788127701.123 2 -> S: NICK bar 1788127701.123 2 -> S: USER username * * :Realname 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.123511Z#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 } 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.123598Z#x1B[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 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.123629Z#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 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.123675Z#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 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.123777Z#x1B[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 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.123810Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK bar" 1788127701.124 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.123929Z#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: 347, tv_nsec: 245278257 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("bar")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.123978Z#x1B[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 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.124002Z#x1B[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 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.124020Z#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" 1788127701.124 sable_ircd #x1B[2m2026-08-30T22:08:21.124071Z#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: 347, tv_nsec: 245278257 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("bar")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.124555Z#x1B[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 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.124582Z#x1B[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")) 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.124608Z#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 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.124628Z#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: 347, tv_nsec: 245278257 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("bar")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.124671Z#x1B[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)) 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.124849Z#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(882023967748001797)), timestamp: 1788127701, clock: EventClock(1 => 882023964166066180), target: User(UserId(Snowflake(882023967748001795))), details: NewUser(NewUser { nickname: Nickname("bar"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(882023967748001796)), NewUserConnection { user: UserId(Snowflake(882023967748001795)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127701 })) }) }; event clock=EventClock(1 => 882023964166066180) my clock=EventClock(1 => 882023964166066180) 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.124923Z#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 1788127701.125 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125130Z#x1B[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(882023967748001797)), timestamp: 1788127701, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882023967748001795)), 1) }), users_to_notify: [] }) 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125162Z#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(882023967748001797)), timestamp: 1788127701, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882023967748001795)), 1) }), users_to_notify: [] } 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125204Z#x1B[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(882023967748001797)), timestamp: 1788127701, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882023967748001795)), 2), connection: UserConnectionId(Snowflake(882023967748001796)) }), users_to_notify: [] }) 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125223Z#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(882023967748001797)), timestamp: 1788127701, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882023967748001795)), 2), connection: UserConnectionId(Snowflake(882023967748001796)) }), users_to_notify: [] } 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125266Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 001 bar :Welcome to the test Internet Relay Chat network, bar 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125289Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 002 bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125310Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 003 bar :This server was created 2026-08-30 22:08:21.125302082 UTC 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125331Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 004 bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125352Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 005 bar EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125373Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 422 bar :MOTD File is missing 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125405Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :bar!username@localhost MODE bar + 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125420Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125452Z#x1B[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(882023967748001797)), timestamp: 1788127701, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127701.125 sable_ircd #x1B[2m2026-08-30T22:08:21.125472Z#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(882023967748001797)), timestamp: 1788127701, change: EventComplete(EventComplete), users_to_notify: [] } 1788127701.126 S -> 2: :My.Little.Server 001 bar :Welcome to the test Internet Relay Chat network, bar 1788127701.126 S -> 2: :My.Little.Server 002 bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127701.126 S -> 2: :My.Little.Server 003 bar :This server was created 2026-08-30 22:08:21.125302082 UTC 1788127701.126 S -> 2: :My.Little.Server 004 bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127701.126 S -> 2: :My.Little.Server 005 bar EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1788127701.126 S -> 2: :My.Little.Server 422 bar :MOTD File is missing 1788127701.126 sable_history #x1B[2m2027-08-30T22:46:40.340206Z#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(1014305182298873901)), timestamp: 1819666000, clock: EventClock(1 => 1014295353727389718, 50 => 1014304930640633900, 99 => 1014295356898684932), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666000 }) }; event clock=EventClock(1 => 1014295353727389718, 50 => 1014304930640633900, 99 => 1014295356898684932) my clock=EventClock(1 => 1014295353727389718, 50 => 1014304930640633900, 99 => 1014295356898684932) 1788127701.126 sable_history #x1B[2m2027-08-30T22:46:40.342021Z#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 1788127701.126 S -> 2: :bar!username@localhost MODE bar + 1788127701.126 S -> 2: :My.Little.Server NOTICE bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127701.126 2 -> S: PING foo 1788127701.126 sable_ircd #x1B[2m2026-08-30T22:08:21.126119Z#x1B[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 1788127701.126 sable_ircd #x1B[2m2026-08-30T22:08:21.126155Z#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" 1788127701.126 sable_ircd #x1B[2m2026-08-30T22:08:21.126220Z#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 1788127701.137 sable_history #x1B[2m2027-08-30T22:30:47.716010Z#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(1014301186704220187)), timestamp: 1819665047, clock: EventClock(1 => 1014295135892017153, 50 => 1014300935045980186), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665047 }) }; event clock=EventClock(1 => 1014295135892017153, 50 => 1014300935045980186) my clock=EventClock(1 => 1014295135892017153, 50 => 1014300935045980186) 1788127701.137 sable_history #x1B[2m2027-08-30T22:30:47.717188Z#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 1788127701.637 sable_history #x1B[2m2027-08-30T22:49:46.047673Z#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(1014305961210486832)), timestamp: 1819666186, clock: EventClock(1 => 1014295552021499922, 50 => 1014305709552246831, 99 => 1014295555868078086), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666186 }) }; event clock=EventClock(1 => 1014295552021499922, 50 => 1014305709552246831, 99 => 1014295555868078086) my clock=EventClock(1 => 1014295552021499922, 50 => 1014305709552246831, 99 => 1014295555868078086) 1788127701.637 sable_history #x1B[2m2027-08-30T22:49:46.049124Z#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 1788127701.756 sable_history #x1B[2m2027-08-30T22:30:48.191853Z#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(1014301188696514587)), timestamp: 1819665048, clock: EventClock(1 => 1014295138538622977, 50 => 1014300937038274586), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665048 }) }; event clock=EventClock(1 => 1014295138538622977, 50 => 1014300937038274586) my clock=EventClock(1 => 1014295138538622977, 50 => 1014300937038274586) 1788127701.756 sable_history #x1B[2m2027-08-30T22:30:48.193629Z#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 1788127701.927 2 -> S: PING synchronize348.048502482 1788127701.927 S -> 2: :My.Little.Server PONG My.Little.Server :foo 1788127701.927 sable_ircd #x1B[2m2026-08-30T22:08:21.927327Z#x1B[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 1788127701.927 sable_ircd #x1B[2m2026-08-30T22:08:21.927405Z#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 synchronize348.048502482" 1788127701.928 sable_ircd #x1B[2m2026-08-30T22:08:21.927536Z#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 :synchronize348.048502482 1788127701.928 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize348.048502482 1788127701.928 2 -> S: JOIN #chan 1788127701.928 sable_ircd #x1B[2m2026-08-30T22:08:21.927996Z#x1B[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 1788127701.928 sable_ircd #x1B[2m2026-08-30T22:08:21.928025Z#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" 1788127701.964 sable_history #x1B[2m2027-08-30T22:36:24.671133Z#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(1014302599995924514)), timestamp: 1819665384, clock: EventClock(1 => 1014295541992919062, 50 => 1014302348337684513, 99 => 1014295545160019972), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665384 }) }; event clock=EventClock(1 => 1014295541992919062, 50 => 1014302348337684513, 99 => 1014295545160019972) my clock=EventClock(1 => 1014295541992919062, 50 => 1014302348337684513, 99 => 1014295545160019972) 1788127701.964 sable_history #x1B[2m2027-08-30T22:36:24.672527Z#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 1788127702.028 2 -> S: PING synchronize348.149557603 1788127702.028 sable_ircd #x1B[2m2026-08-30T22:08:22.028442Z#x1B[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 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.028493Z#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 synchronize348.149557603" 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.028793Z#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(882023971539652614)), timestamp: 1788127702, clock: EventClock(1 => 882023967748001797), target: Membership(MembershipId(UserId(Snowflake(882023967748001795)), ChannelId(Snowflake(882023964161871874)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882023964161871874)), user: UserId(Snowflake(882023967748001795)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882023967748001797) my clock=EventClock(1 => 882023967748001797) 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.028913Z#x1B[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 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.028938Z#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 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.029123Z#x1B[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(882023971539652614)), timestamp: 1788127702, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882023967748001795)), ChannelId(Snowflake(882023964161871874))), user: HistoricUserId(UserId(Snowflake(882023967748001795)), 2) }), users_to_notify: [UserId(Snowflake(882023967748001795)), UserId(Snowflake(882023960793845760))] }) 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.029154Z#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(882023971539652614)), timestamp: 1788127702, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882023967748001795)), ChannelId(Snowflake(882023964161871874))), user: HistoricUserId(UserId(Snowflake(882023967748001795)), 2) }), users_to_notify: [UserId(Snowflake(882023967748001795)), UserId(Snowflake(882023960793845760))] } 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.029205Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :bar!username@localhost JOIN #chan 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.029239Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 353 bar = #chan :bar @foo 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.029251Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 366 bar #chan :End of names list 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.029265Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :bar!username@localhost JOIN #chan 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.029296Z#x1B[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(882023971539652614)), timestamp: 1788127702, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127702.029 sable_ircd #x1B[2m2026-08-30T22:08:22.029309Z#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(882023971539652614)), timestamp: 1788127702, change: EventComplete(EventComplete), users_to_notify: [] } 1788127702.030 S -> 2: :bar!username@localhost JOIN #chan 1788127702.070 S -> 2: :My.Little.Server 353 bar = #chan :bar @foo 1788127702.071 S -> 2: :My.Little.Server 366 bar #chan :End of names list 1788127702.313 sable_history #x1B[2m2027-08-30T22:30:48.942856Z#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(1014301191850631195)), timestamp: 1819665048, clock: EventClock(1 => 1014295140782575617, 50 => 1014300940188196890), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665048 }) }; event clock=EventClock(1 => 1014295140782575617, 50 => 1014300940188196890) my clock=EventClock(1 => 1014295140782575617, 50 => 1014300940188196890) 1788127702.313 sable_history #x1B[2m2027-08-30T22:30:48.944401Z#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 1788127702.700 sable_history #x1B[2m2027-08-30T22:39:14.293831Z#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(1014303311446351909)), timestamp: 1819665554, clock: EventClock(1 => 1014295494442094614, 50 => 1014303059788111908, 99 => 1014295497634361348), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665554 }) }; event clock=EventClock(1 => 1014295494442094614, 50 => 1014303059788111908, 99 => 1014295497634361348) my clock=EventClock(1 => 1014295494442094614, 50 => 1014303059788111908, 99 => 1014295497634361348) 1788127702.700 sable_history #x1B[2m2027-08-30T22:39:14.295285Z#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 1788127702.746 sable_history #x1B[2m2027-08-30T22:30:49.168224Z#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(1014301192794349595)), timestamp: 1819665049, clock: EventClock(1 => 1014295142766481409, 50 => 1014300941136109594), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665049 }) }; event clock=EventClock(1 => 1014295142766481409, 50 => 1014300941136109594) my clock=EventClock(1 => 1014295142766481409, 50 => 1014300941136109594) 1788127702.746 sable_history #x1B[2m2027-08-30T22:30:49.169817Z#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 1788127703.035 sable_ircd #x1B[2m2026-08-30T22:08:23.034652Z#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 :synchronize348.149557603 1788127703.035 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize348.149557603 1788127703.035 3: connects to server. 1788127703.035 3 -> S: NICK baz 1788127703.035 3 -> S: USER username * * :Realname 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.035560Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 4), remote_addr: 127.0.0.1, tls_info: None } 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.035649Z#x1B[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 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.035687Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.035741Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Looking up your hostname 1788127703.036 S -> 3: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.035840Z#x1B[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 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.035871Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK baz" 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.035976Z#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: 349, tv_nsec: 157346152 }, 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 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.036025Z#x1B[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 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.036045Z#x1B[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 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.036061Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER username * * :Realname" 1788127703.036 sable_ircd #x1B[2m2026-08-30T22:08:23.036108Z#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: 349, tv_nsec: 157346152 }, 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 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.036606Z#x1B[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 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.036631Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 4): 127.0.0.1/Some(Hostname("localhost")) 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.036651Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.036667Z#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: 349, tv_nsec: 157346152 }, 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 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.036697Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mRegisterClient(ConnectionId(ListenerId(0), 4)) 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.036883Z#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(882023975767511047)), timestamp: 1788127703, clock: EventClock(1 => 882023971539652614), target: User(UserId(Snowflake(882023975767511045))), 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(882023975767511046)), NewUserConnection { user: UserId(Snowflake(882023975767511045)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127703 })) }) }; event clock=EventClock(1 => 882023971539652614) my clock=EventClock(1 => 882023971539652614) 1788127703.037 S -> 3: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.036963Z#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 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037169Z#x1B[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(882023975767511047)), timestamp: 1788127703, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882023975767511045)), 1) }), users_to_notify: [] }) 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037199Z#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(882023975767511047)), timestamp: 1788127703, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882023975767511045)), 1) }), users_to_notify: [] } 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037232Z#x1B[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(882023975767511047)), timestamp: 1788127703, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882023975767511045)), 2), connection: UserConnectionId(Snowflake(882023975767511046)) }), users_to_notify: [] }) 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037245Z#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(882023975767511047)), timestamp: 1788127703, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882023975767511045)), 2), connection: UserConnectionId(Snowflake(882023975767511046)) }), users_to_notify: [] } 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037279Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 001 baz :Welcome to the test Internet Relay Chat network, baz 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037295Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 002 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037310Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 003 baz :This server was created 2026-08-30 22:08:23.037303257 UTC 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037326Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 004 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037339Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 005 baz EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037350Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 422 baz :MOTD File is missing 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037362Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :baz!username@localhost MODE baz + 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037372Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037413Z#x1B[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(882023975767511047)), timestamp: 1788127703, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127703.037 sable_ircd #x1B[2m2026-08-30T22:08:23.037432Z#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(882023975767511047)), timestamp: 1788127703, change: EventComplete(EventComplete), users_to_notify: [] } 1788127703.038 S -> 3: :My.Little.Server 001 baz :Welcome to the test Internet Relay Chat network, baz 1788127703.038 S -> 3: :My.Little.Server 002 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127703.038 3 -> S: PING foo 1788127703.038 sable_ircd #x1B[2m2026-08-30T22:08:23.037821Z#x1B[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 1788127703.038 sable_ircd #x1B[2m2026-08-30T22:08:23.037849Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING foo" 1788127703.038 sable_ircd #x1B[2m2026-08-30T22:08:23.037900Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :foo 1788127703.128 sable_history #x1B[2m2027-08-30T22:30:49.548172Z#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(1014301194388185115)), timestamp: 1819665049, clock: EventClock(1 => 1014295144268042241, 50 => 1014300942729945114), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665049 }) }; event clock=EventClock(1 => 1014295144268042241, 50 => 1014300942729945114) my clock=EventClock(1 => 1014295144268042241, 50 => 1014300942729945114) 1788127703.128 sable_history #x1B[2m2027-08-30T22:30:49.549711Z#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 1788127703.238 3 -> S: PING synchronize349.359474996 1788127703.238 S -> 3: :My.Little.Server 003 baz :This server was created 2026-08-30 22:08:23.037303257 UTC 1788127703.238 S -> 3: :My.Little.Server 004 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127703.238 S -> 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 1788127703.238 S -> 3: :My.Little.Server 422 baz :MOTD File is missing 1788127703.238 S -> 3: :baz!username@localhost MODE baz + 1788127703.238 S -> 3: :My.Little.Server NOTICE baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127703.238 S -> 3: :My.Little.Server PONG My.Little.Server :foo 1788127703.238 sable_ircd #x1B[2m2026-08-30T22:08:23.238294Z#x1B[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 1788127703.238 sable_ircd #x1B[2m2026-08-30T22:08:23.238351Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize349.359474996" 1788127703.239 sable_ircd #x1B[2m2026-08-30T22:08:23.238473Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :synchronize349.359474996 1788127703.239 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize349.359474996 1788127703.632 sable_history #x1B[2m2027-08-30T22:42:02.100604Z#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(1014304015275728936)), timestamp: 1819665722, clock: EventClock(1 => 1014295448346693654, 50 => 1014303763617488935, 99 => 1014295451547348996), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665722 }) }; event clock=EventClock(1 => 1014295448346693654, 50 => 1014303763617488935, 99 => 1014295451547348996) my clock=EventClock(1 => 1014295448346693654, 50 => 1014303763617488935, 99 => 1014295451547348996) 1788127703.632 sable_history #x1B[2m2027-08-30T22:42:02.102046Z#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 1788127703.649 sable_history #x1B[2m2027-08-30T22:30:50.148063Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(1014301196904767516)), timestamp: 1819665050, clock: EventClock(1 => 1014295224354082831, 50 => 1014300945246527515, 99 => 1014295214413983748), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665050 }) }; event clock=EventClock(1 => 1014295224354082831, 50 => 1014300945246527515, 99 => 1014295214413983748) my clock=EventClock(1 => 1014295224354082831, 50 => 1014300945246527515, 99 => 1014295214413983748) 1788127703.649 sable_history #x1B[2m2027-08-30T22:30:50.149114Z#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 1788127703.839 3 -> S: JOIN #chan 1788127703.840 sable_ircd #x1B[2m2026-08-30T22:08:23.839879Z#x1B[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 1788127703.840 sable_ircd #x1B[2m2026-08-30T22:08:23.839940Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"JOIN #chan" 1788127703.940 3 -> S: PING synchronize350.061177894 1788127703.940 sable_ircd #x1B[2m2026-08-30T22:08:23.940052Z#x1B[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 1788127703.940 sable_ircd #x1B[2m2026-08-30T22:08:23.940108Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize350.061177894" 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.190888Z#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(882023980607737864)), timestamp: 1788127704, clock: EventClock(1 => 882023975767511047), target: Membership(MembershipId(UserId(Snowflake(882023975767511045)), ChannelId(Snowflake(882023964161871874)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882023964161871874)), user: UserId(Snowflake(882023975767511045)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882023975767511047) my clock=EventClock(1 => 882023975767511047) 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191023Z#x1B[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 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191045Z#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 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191231Z#x1B[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(882023980607737864)), timestamp: 1788127704, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882023975767511045)), ChannelId(Snowflake(882023964161871874))), user: HistoricUserId(UserId(Snowflake(882023975767511045)), 2) }), users_to_notify: [UserId(Snowflake(882023967748001795)), UserId(Snowflake(882023975767511045)), UserId(Snowflake(882023960793845760))] }) 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191259Z#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(882023980607737864)), timestamp: 1788127704, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882023975767511045)), ChannelId(Snowflake(882023964161871874))), user: HistoricUserId(UserId(Snowflake(882023975767511045)), 2) }), users_to_notify: [UserId(Snowflake(882023967748001795)), UserId(Snowflake(882023975767511045)), UserId(Snowflake(882023960793845760))] } 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191305Z#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 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191330Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :baz!username@localhost JOIN #chan 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191358Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 353 baz = #chan :bar baz @foo 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191369Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 366 baz #chan :End of names list 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191411Z#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 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191438Z#x1B[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(882023980607737864)), timestamp: 1788127704, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127704.191 sable_ircd #x1B[2m2026-08-30T22:08:24.191449Z#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(882023980607737864)), timestamp: 1788127704, change: EventComplete(EventComplete), users_to_notify: [] } 1788127704.192 S -> 3: :baz!username@localhost JOIN #chan 1788127704.192 S -> 3: :My.Little.Server 353 baz = #chan :bar baz @foo 1788127704.192 S -> 3: :My.Little.Server 366 baz #chan :End of names list 1788127704.509 sable_history #x1B[2m2027-08-30T22:44:51.009594Z#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(1014304723731423275)), timestamp: 1819665891, clock: EventClock(1 => 1014295401760559126, 50 => 1014304472073183274, 99 => 1014295404927660036), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665891 }) }; event clock=EventClock(1 => 1014295401760559126, 50 => 1014304472073183274, 99 => 1014295404927660036) my clock=EventClock(1 => 1014295401760559126, 50 => 1014304472073183274, 99 => 1014295404927660036) 1788127704.509 sable_history #x1B[2m2027-08-30T22:44:51.011138Z#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 1788127704.899 sable_history #x1B[2m2027-08-30T22:34:35.382939Z#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(1014302141608828960)), timestamp: 1819665275, clock: EventClock(1 => 1014295842380582945, 50 => 1014301889950588959, 99 => 1014295842997547013), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665275 }) }; event clock=EventClock(1 => 1014295842380582945, 50 => 1014301889950588959, 99 => 1014295842997547013) my clock=EventClock(1 => 1014295842380582945, 50 => 1014301889950588959, 99 => 1014295842997547013) 1788127704.899 sable_history #x1B[2m2027-08-30T22:34:35.384416Z#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 1788127705.126 sable_history #x1B[2m2027-08-30T22:47:40.339824Z#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(1014305433957113902)), timestamp: 1819666060, clock: EventClock(1 => 1014295353727389718, 50 => 1014305182298873901, 99 => 1014295356898684932), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666060 }) }; event clock=EventClock(1 => 1014295353727389718, 50 => 1014305182298873901, 99 => 1014295356898684932) my clock=EventClock(1 => 1014295353727389718, 50 => 1014305182298873901, 99 => 1014295356898684932) 1788127705.126 sable_history #x1B[2m2027-08-30T22:47:40.341274Z#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 1788127705.137 sable_history #x1B[2m2027-08-30T22:31:47.716311Z#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(1014301438362460188)), timestamp: 1819665107, clock: EventClock(1 => 1014295135892017153, 50 => 1014301186704220187), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665107 }) }; event clock=EventClock(1 => 1014295135892017153, 50 => 1014301186704220187) my clock=EventClock(1 => 1014295135892017153, 50 => 1014301186704220187) 1788127705.137 sable_history #x1B[2m2027-08-30T22:31:47.717454Z#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 1788127705.193 3: waiting… 1788127705.196 sable_ircd #x1B[2m2026-08-30T22:08:25.195872Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :synchronize350.061177894 1788127705.196 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize350.061177894 1788127705.297 1 -> S: PING synchronize351.418063012 1788127705.297 S -> 1: :bar!username@localhost JOIN #chan 1788127705.297 S -> 1: :baz!username@localhost JOIN #chan 1788127705.297 sable_ircd #x1B[2m2026-08-30T22:08:25.296926Z#x1B[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 1788127705.297 sable_ircd #x1B[2m2026-08-30T22:08:25.296980Z#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 synchronize351.418063012" 1788127705.297 sable_ircd #x1B[2m2026-08-30T22:08:25.297086Z#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 :synchronize351.418063012 1788127705.297 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize351.418063012 1788127705.397 2 -> S: PING synchronize351.519028948 1788127705.398 S -> 2: :baz!username@localhost JOIN #chan 1788127705.398 sable_ircd #x1B[2m2026-08-30T22:08:25.397897Z#x1B[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 1788127705.398 sable_ircd #x1B[2m2026-08-30T22:08:25.397948Z#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 synchronize351.519028948" 1788127705.398 sable_ircd #x1B[2m2026-08-30T22:08:25.398047Z#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 :synchronize351.519028948 1788127705.398 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize351.519028948 1788127705.498 3 -> S: PING synchronize351.619991942 1788127705.499 sable_ircd #x1B[2m2026-08-30T22:08:25.498852Z#x1B[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 1788127705.499 sable_ircd #x1B[2m2026-08-30T22:08:25.498901Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize351.619991942" 1788127705.637 sable_history #x1B[2m2027-08-30T22:50:46.047551Z#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(1014306212868726833)), timestamp: 1819666246, clock: EventClock(1 => 1014295552021499922, 50 => 1014305961210486832, 99 => 1014295555868078086), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666246 }) }; event clock=EventClock(1 => 1014295552021499922, 50 => 1014305961210486832, 99 => 1014295555868078086) my clock=EventClock(1 => 1014295552021499922, 50 => 1014305961210486832, 99 => 1014295555868078086) 1788127705.637 sable_history #x1B[2m2027-08-30T22:50:46.049102Z#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 1788127705.755 sable_history #x1B[2m2027-08-30T22:31:48.190489Z#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(1014301440350560284)), timestamp: 1819665108, clock: EventClock(1 => 1014295138538622977, 50 => 1014301188696514587), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665108 }) }; event clock=EventClock(1 => 1014295138538622977, 50 => 1014301188696514587) my clock=EventClock(1 => 1014295138538622977, 50 => 1014301188696514587) 1788127705.756 sable_history #x1B[2m2027-08-30T22:31:48.192310Z#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 1788127705.964 sable_history #x1B[2m2027-08-30T22:37:24.671246Z#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(1014302851654164515)), timestamp: 1819665444, clock: EventClock(1 => 1014295541992919062, 50 => 1014302599995924514, 99 => 1014295545160019972), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665444 }) }; event clock=EventClock(1 => 1014295541992919062, 50 => 1014302599995924514, 99 => 1014295545160019972) my clock=EventClock(1 => 1014295541992919062, 50 => 1014302599995924514, 99 => 1014295545160019972) 1788127705.964 sable_history #x1B[2m2027-08-30T22:37:24.672633Z#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 1788127706.002 sable_ircd #x1B[2m2026-08-30T22:08:26.002150Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :synchronize351.619991942 1788127706.003 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize351.619991942 1788127706.003 1 -> S: KICK #chan bar 1788127706.003 sable_ircd #x1B[2m2026-08-30T22:08:26.002890Z#x1B[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 1788127706.003 sable_ircd #x1B[2m2026-08-30T22:08:26.002927Z#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"KICK #chan bar" 1788127706.003 sable_ircd #x1B[2m2026-08-30T22:08:26.003148Z#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(882023988212011017)), timestamp: 1788127706, clock: EventClock(1 => 882023980607737864), target: Membership(MembershipId(UserId(Snowflake(882023967748001795)), ChannelId(Snowflake(882023964161871874)))), details: ChannelKick(ChannelKick { source: UserId(Snowflake(882023960793845760)), message: "foo" }) }; event clock=EventClock(1 => 882023980607737864) my clock=EventClock(1 => 882023980607737864) 1788127706.003 sable_ircd #x1B[2m2026-08-30T22:08:26.003272Z#x1B[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 1788127706.003 sable_ircd #x1B[2m2026-08-30T22:08:26.003280Z#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 1788127706.004 sable_ircd #x1B[2m2026-08-30T22:08:26.003475Z#x1B[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(882023988212011017)), timestamp: 1788127706, change: ChannelKick(ChannelKick { membership: Membership { id: MembershipId(UserId(Snowflake(882023967748001795)), ChannelId(Snowflake(882023964161871874))), channel: ChannelId(Snowflake(882023964161871874)), user: UserId(Snowflake(882023967748001795)), permissions: MembershipFlagSet(0) }, source: User(HistoricUserId(UserId(Snowflake(882023960793845760)), 2)), user: HistoricUserId(UserId(Snowflake(882023967748001795)), 2), message: "foo" }), users_to_notify: [UserId(Snowflake(882023975767511045)), UserId(Snowflake(882023960793845760)), UserId(Snowflake(882023967748001795))] }) 1788127706.004 sable_ircd #x1B[2m2026-08-30T22:08:26.003508Z#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(882023988212011017)), timestamp: 1788127706, change: ChannelKick(ChannelKick { membership: Membership { id: MembershipId(UserId(Snowflake(882023967748001795)), ChannelId(Snowflake(882023964161871874))), channel: ChannelId(Snowflake(882023964161871874)), user: UserId(Snowflake(882023967748001795)), permissions: MembershipFlagSet(0) }, source: User(HistoricUserId(UserId(Snowflake(882023960793845760)), 2)), user: HistoricUserId(UserId(Snowflake(882023967748001795)), 2), message: "foo" }), users_to_notify: [UserId(Snowflake(882023975767511045)), UserId(Snowflake(882023960793845760)), UserId(Snowflake(882023967748001795))] } 1788127706.004 sable_ircd #x1B[2m2026-08-30T22:08:26.003556Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :foo!username@localhost KICK #chan bar :foo 1788127706.004 sable_ircd #x1B[2m2026-08-30T22:08:26.003575Z#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 KICK #chan bar :foo 1788127706.004 sable_ircd #x1B[2m2026-08-30T22:08:26.003590Z#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): :foo!username@localhost KICK #chan bar :foo 1788127706.004 sable_ircd #x1B[2m2026-08-30T22:08:26.003617Z#x1B[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(882023988212011017)), timestamp: 1788127706, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127706.004 sable_ircd #x1B[2m2026-08-30T22:08:26.003629Z#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(882023988212011017)), timestamp: 1788127706, change: EventComplete(EventComplete), users_to_notify: [] } 1788127706.103 1 -> S: PING synchronize352.2244283 1788127706.103 S -> 1: :foo!username@localhost KICK #chan bar :foo 1788127706.103 sable_ircd #x1B[2m2026-08-30T22:08:26.103285Z#x1B[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 1788127706.103 sable_ircd #x1B[2m2026-08-30T22:08:26.103347Z#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 synchronize352.2244283" 1788127706.104 sable_ircd #x1B[2m2026-08-30T22:08:26.103489Z#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 :synchronize352.2244283 1788127706.104 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize352.2244283 1788127706.204 2 -> S: PING synchronize352.325456498 1788127706.204 S -> 2: :foo!username@localhost KICK #chan bar :foo 1788127706.204 sable_ircd #x1B[2m2026-08-30T22:08:26.204198Z#x1B[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 1788127706.204 sable_ircd #x1B[2m2026-08-30T22:08:26.204249Z#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 synchronize352.325456498" 1788127706.204 sable_ircd #x1B[2m2026-08-30T22:08:26.204355Z#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 :synchronize352.325456498 1788127706.205 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize352.325456498 1788127706.305 3 -> S: PING synchronize352.426313986 1788127706.305 S -> 3: :foo!username@localhost KICK #chan bar :foo 1788127706.305 sable_ircd #x1B[2m2026-08-30T22:08:26.305031Z#x1B[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 1788127706.305 sable_ircd #x1B[2m2026-08-30T22:08:26.305079Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize352.426313986" 1788127706.313 sable_history #x1B[2m2027-08-30T22:31:48.941750Z#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(1014301443504676892)), timestamp: 1819665108, clock: EventClock(1 => 1014295140782575617, 50 => 1014301191850631195), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665108 }) }; event clock=EventClock(1 => 1014295140782575617, 50 => 1014301191850631195) my clock=EventClock(1 => 1014295140782575617, 50 => 1014301191850631195) 1788127706.313 sable_history #x1B[2m2027-08-30T22:31:48.943433Z#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 1788127706.700 sable_history #x1B[2m2027-08-30T22:40:14.293821Z#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(1014303563104591910)), timestamp: 1819665614, clock: EventClock(1 => 1014295494442094614, 50 => 1014303311446351909, 99 => 1014295497634361348), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665614 }) }; event clock=EventClock(1 => 1014295494442094614, 50 => 1014303311446351909, 99 => 1014295497634361348) my clock=EventClock(1 => 1014295494442094614, 50 => 1014303311446351909, 99 => 1014295497634361348) 1788127706.700 sable_history #x1B[2m2027-08-30T22:40:14.295278Z#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 1788127706.746 sable_history #x1B[2m2027-08-30T22:31:49.168006Z#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(1014301444452589596)), timestamp: 1819665109, clock: EventClock(1 => 1014295142766481409, 50 => 1014301192794349595), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665109 }) }; event clock=EventClock(1 => 1014295142766481409, 50 => 1014301192794349595) my clock=EventClock(1 => 1014295142766481409, 50 => 1014301192794349595) 1788127706.746 sable_history #x1B[2m2027-08-30T22:31:49.169462Z#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 1788127707.058 sable_ircd #x1B[2m2026-08-30T22:08:27.057748Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :synchronize352.426313986 1788127707.058 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize352.426313986 1788127707.128 sable_history #x1B[2m2027-08-30T22:31:49.547736Z#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(1014301446046425116)), timestamp: 1819665109, clock: EventClock(1 => 1014295144268042241, 50 => 1014301194388185115), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665109 }) }; event clock=EventClock(1 => 1014295144268042241, 50 => 1014301194388185115) my clock=EventClock(1 => 1014295144268042241, 50 => 1014301194388185115) 1788127707.128 sable_history #x1B[2m2027-08-30T22:31:49.549309Z#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 1788127707.212 1: disconnects from server. 1788127707.212 2: disconnects from server. 1788127707.212 3: disconnects from server.