--------------------------------- Captured Out --------------------------------- ---- new test ---- 1774773226.275 sable_ircd uid=1001 1774773226.275 sable_services uid=1001 1774773226.276 sable_services #x1B[2m2026-03-29T08:33:46.276235Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.Server"), address: "127.0.0.1:60805", fingerprint: "71b2e0ece817ea1126761d597d5620a4ad65e8ff" } 1774773226.277 sable_services #x1B[2m2026-03-29T08:33:46.276503Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:60805. Last error: I/O error: Connection refused (os error 111) 1774773226.277 sable_services #x1B[2m2026-03-29T08:33:46.276559Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1774773226.279 sable_ircd #x1B[2m2026-03-29T08:33:46.278498Z#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(826011240483524608)), timestamp: 1774773226, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Server"), ts: 1774773226, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1774773226.279 sable_ircd #x1B[2m2026-03-29T08:33:46.278620Z#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 1774773226.279 sable_ircd #x1B[2m2026-03-29T08:33:46.278825Z#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(826011240483524608)), timestamp: 1774773226, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Server"), ts: 1774773226, 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 1774773226.279 sable_ircd #x1B[2m2026-03-29T08:33:46.278986Z#x1B[0m #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(826011240483524608)), timestamp: 1774773226, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1774773226.279 sable_ircd #x1B[2m2026-03-29T08:33:46.279026Z#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(826011240483524608)), timestamp: 1774773226, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1774773226.279 sable_ircd #x1B[2m2026-03-29T08:33:46.279094Z#x1B[0m #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(826011240483524608)), timestamp: 1774773226, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773226.279 sable_ircd #x1B[2m2026-03-29T08:33:46.279123Z#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(826011240483524608)), timestamp: 1774773226, change: EventComplete(EventComplete), users_to_notify: [] } 1774773226.280 sable_ircd #x1B[2m2026-03-29T08:33:46.279712Z#x1B[0m #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 1774773226.280 sable_ircd #x1B[2m2026-03-29T08:33:46.279909Z#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(826011240487718913)), timestamp: 1774773226, clock: EventClock(1 => 826011240483524608), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1774773226 }) }; event clock=EventClock(1 => 826011240483524608) my clock=EventClock(1 => 826011240483524608) 1774773226.280 sable_ircd #x1B[2m2026-03-29T08:33:46.279972Z#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 1774773226.280 sable_ircd #x1B[2m2026-03-29T08:33:46.280135Z#x1B[0m #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(826011240487718913)), timestamp: 1774773226, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773226.280 sable_ircd #x1B[2m2026-03-29T08:33:46.280163Z#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(826011240487718913)), timestamp: 1774773226, change: EventComplete(EventComplete), users_to_notify: [] } 1774773226.369 sable_ircd #x1B[2m2026-03-29T08:33:46.368612Z#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 } 1774773226.369 sable_ircd #x1B[2m2026-03-29T08:33:46.368793Z#x1B[0m #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 1774773226.369 sable_ircd #x1B[2m2026-03-29T08:33:46.368841Z#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 1774773226.369 sable_ircd #x1B[2m2026-03-29T08:33:46.368906Z#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 1774773226.369 sable_ircd #x1B[2m2026-03-29T08:33:46.369056Z#x1B[0m #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 1774773226.369 sable_ircd #x1B[2m2026-03-29T08:33:46.369127Z#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" 1774773226.369 sable_ircd #x1B[2m2026-03-29T08:33:46.369272Z#x1B[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 1774773226.369 sable_ircd #x1B[2m2026-03-29T08:33:46.369402Z#x1B[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)) 1774773226.369 sable_ircd #x1B[2m2026-03-29T08:33:46.369438Z#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) 1774773226.370 sable_ircd #x1B[2m2026-03-29T08:33:46.369927Z#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 1774773226.370 sable_ircd #x1B[2m2026-03-29T08:33:46.370020Z#x1B[0m #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 1774773226.370 sable_ircd #x1B[2m2026-03-29T08:33:46.370215Z#x1B[0m #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 1774773226.390 chkSvs: connects to server. 1774773226.390 chkSvs -> S: NICK chkSvs 1774773226.390 chkSvs -> S: USER chk chk chk chk 1774773226.390 sable_ircd #x1B[2m2026-03-29T08:33:46.390013Z#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 } 1774773226.390 sable_ircd #x1B[2m2026-03-29T08:33:46.390120Z#x1B[0m #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 1774773226.390 sable_ircd #x1B[2m2026-03-29T08:33:46.390165Z#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 1774773226.390 sable_ircd #x1B[2m2026-03-29T08:33:46.390218Z#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 1774773226.390 sable_ircd #x1B[2m2026-03-29T08:33:46.390346Z#x1B[0m #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 1774773226.390 sable_ircd #x1B[2m2026-03-29T08:33:46.390401Z#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 chkSvs" 1774773226.391 sable_ircd #x1B[2m2026-03-29T08:33:46.390563Z#x1B[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: 530, tv_nsec: 608575266 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("chkSvs")), 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 1774773226.391 sable_ircd #x1B[2m2026-03-29T08:33:46.390653Z#x1B[0m #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 1774773226.391 sable_ircd #x1B[2m2026-03-29T08:33:46.390707Z#x1B[0m #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 1774773226.391 sable_ircd #x1B[2m2026-03-29T08:33:46.390751Z#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 chk chk chk chk" 1774773226.391 sable_ircd #x1B[2m2026-03-29T08:33:46.390834Z#x1B[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: 530, tv_nsec: 608575266 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), 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 1774773226.391 sable_ircd #x1B[2m2026-03-29T08:33:46.391274Z#x1B[0m #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 1774773226.391 sable_ircd #x1B[2m2026-03-29T08:33:46.391318Z#x1B[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")) 1774773226.391 sable_ircd #x1B[2m2026-03-29T08:33:46.391364Z#x1B[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 1774773226.391 sable_ircd #x1B[2m2026-03-29T08:33:46.391403Z#x1B[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: 530, tv_nsec: 608575266 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), 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 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.391468Z#x1B[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)) 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.391751Z#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(826011240957480962)), timestamp: 1774773226, clock: EventClock(1 => 826011240487718913), target: User(UserId(Snowflake(826011240957480960))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(826011240957480961)), NewUserConnection { user: UserId(Snowflake(826011240957480960)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773226 })) }) }; event clock=EventClock(1 => 826011240487718913) my clock=EventClock(1 => 826011240487718913) 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.391855Z#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 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392118Z#x1B[0m #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(826011240957480962)), timestamp: 1774773226, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(826011240957480960)), 1) }), users_to_notify: [] }) 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392160Z#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(826011240957480962)), timestamp: 1774773226, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(826011240957480960)), 1) }), users_to_notify: [] } 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392202Z#x1B[0m #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(826011240957480962)), timestamp: 1774773226, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(826011240957480960)), 2), connection: UserConnectionId(Snowflake(826011240957480961)) }), users_to_notify: [] }) 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392224Z#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(826011240957480962)), timestamp: 1774773226, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(826011240957480960)), 2), connection: UserConnectionId(Snowflake(826011240957480961)) }), users_to_notify: [] } 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392265Z#x1B[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 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392291Z#x1B[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 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392312Z#x1B[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 chkSvs :This server was created 2026-03-29 08:33:46.392304350 UTC 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392326Z#x1B[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 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392353Z#x1B[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 chkSvs 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 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392371Z#x1B[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 chkSvs :MOTD File is missing 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392389Z#x1B[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): :chkSvs!chk@localhost MODE chkSvs + 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392400Z#x1B[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 chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392425Z#x1B[0m #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(826011240957480962)), timestamp: 1774773226, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773226.392 sable_ircd #x1B[2m2026-03-29T08:33:46.392443Z#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(826011240957480962)), timestamp: 1774773226, change: EventComplete(EventComplete), users_to_notify: [] } 1774773226.417 sable_services #x1B[2m2026-03-29T08:33:46.417135Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.History"), address: "127.0.0.1:50247", fingerprint: "b474ec334ce1de364b140f00f07163cd4d6efbde" } 1774773226.417 sable_services #x1B[2m2026-03-29T08:33:46.417360Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:50247. Last error: I/O error: Connection refused (os error 111) 1774773226.417 sable_services #x1B[2m2026-03-29T08:33:46.417407Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1774773226.490 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname 1774773226.490 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1774773226.490 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1774773226.490 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1774773226.490 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2026-03-29 08:33:46.392304350 UTC 1774773226.490 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1774773226.490 S -> chkSvs: :My.Little.Server 005 chkSvs 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 1774773226.490 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing 1774773226.490 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs + 1774773226.490 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1774773226.490 chkSvs -> S: CAP LS 302 1774773226.491 sable_ircd #x1B[2m2026-03-29T08:33:46.490759Z#x1B[0m #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 1774773226.491 sable_ircd #x1B[2m2026-03-29T08:33:46.490824Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP LS 302" 1774773226.491 sable_ircd #x1B[2m2026-03-29T08:33:46.490976Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1774773226.540 chkSvs -> S: PING synchronize530.758707801 1774773226.540 S -> chkSvs: :My.Little.Server CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1774773226.541 sable_ircd #x1B[2m2026-03-29T08:33:46.540974Z#x1B[0m #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 1774773226.541 sable_ircd #x1B[2m2026-03-29T08:33:46.541043Z#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 synchronize530.758707801" 1774773226.541 sable_ircd #x1B[2m2026-03-29T08:33:46.541177Z#x1B[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 :synchronize530.758707801 1774773226.541 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize530.758707801 1774773226.542 chkSvs -> S: CAP LS 302 1774773226.542 sable_ircd #x1B[2m2026-03-29T08:33:46.541787Z#x1B[0m #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 1774773226.542 sable_ircd #x1B[2m2026-03-29T08:33:46.541827Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP LS 302" 1774773226.546 sable_services #x1B[2m2026-03-29T08:33:46.546070Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.History"), address: "127.0.0.1:50247", fingerprint: "b474ec334ce1de364b140f00f07163cd4d6efbde" } (attempt #3). 1774773226.546 sable_services #x1B[2m2026-03-29T08:33:46.546127Z#x1B[0m #x1B[33m WARN#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Make sure at least one node in your network is started and reachable. If this is the first (or only) node, you must provide the --bootstrap-network option. 1774773226.547 sable_services #x1B[2m2026-03-29T08:33:46.546438Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:50247. Last error: I/O error: Connection refused (os error 111) 1774773226.547 sable_services #x1B[2m2026-03-29T08:33:46.546487Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1774773226.592 chkSvs -> S: PING synchronize530.810025051 1774773226.592 sable_ircd #x1B[2m2026-03-29T08:33:46.592166Z#x1B[0m #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 1774773226.592 sable_ircd #x1B[2m2026-03-29T08:33:46.592225Z#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 synchronize530.810025051" 1774773226.867 sable_services #x1B[2m2026-03-29T08:33:46.867296Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.History"), address: "127.0.0.1:50247", fingerprint: "b474ec334ce1de364b140f00f07163cd4d6efbde" } (attempt #4). 1774773226.868 sable_services #x1B[2m2026-03-29T08:33:46.867585Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:50247. Last error: I/O error: Connection refused (os error 111) 1774773226.868 sable_services #x1B[2m2026-03-29T08:33:46.867672Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1774773227.094 sable_ircd #x1B[2m2026-03-29T08:33:47.094390Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1774773227.095 S -> chkSvs: :My.Little.Server CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1774773227.353 sable_services #x1B[2m2026-03-29T08:33:47.353166Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.Server"), address: "127.0.0.1:60805", fingerprint: "71b2e0ece817ea1126761d597d5620a4ad65e8ff" } (attempt #5). 1774773227.353 sable_services #x1B[2m2026-03-29T08:33:47.353350Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773227.358 sable_ircd #x1B[2m2026-03-29T08:33:47.357780Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::node#x1B[0m#x1B[2m:#x1B[0m Server got state export request; sending 1774773227.399 sable_services #x1B[2m2026-03-29T08:33:47.399217Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Bootstrap message: Message { source_server: (ServerId(1), 1774773226), content: NetworkState(Network { nick_bindings: {Nickname("chkSvs"): NickBinding { nick: Nickname("chkSvs"), user: UserId(Snowflake(826011240957480960)), timestamp: 1774773226, created: EventId(Snowflake(826011240957480962)) }}, historic_nick_users: HistoricNickStore { data: {} }, users: {UserId(Snowflake(826011240957480960)): User { id: UserId(Snowflake(826011240957480960)), serial: 2, user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, mode: UserMode { modes: UserModeSet(0) }, oper_privileges: None, account: None, session_key: None }}, historic_users: HistoricUserStore { users: {HistoricUserId(UserId(Snowflake(826011240957480960)), 1): HistoricUser { id: UserId(Snowflake(826011240957480960)), serial: 1, nickname: Nickname("chkSvs"), user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, account: None, timestamp: Some(1774773226) }, HistoricUserId(UserId(Snowflake(826011240957480960)), 2): HistoricUser { id: UserId(Snowflake(826011240957480960)), serial: 2, nickname: Nickname("chkSvs"), user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, account: None, timestamp: None }} }, user_connections: {UserConnectionId(Snowflake(826011240957480961)): UserConnection { id: UserConnectionId(Snowflake(826011240957480961)), user: UserId(Snowflake(826011240957480960)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773226 }}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1774773226, name: ServerName("My.Little.Server"), last_ping: 1774773226, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }}, network_bans: BanRepository { pre_registration_bans: {}, new_connection_bans: {}, pre_sasl_bans: {}, pre_registration_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: ["", "", "", "", "", ""], uint64: [], regex: [] }, fields: {"ip": (0, Ip(_)), "user_param_2": (3, String(_)), "host": (4, String(_)), "user_param_1": (2, String(_)), "user": (0, String(_)), "realname": (1, String(_)), "tls": (0, Boolean(_)), "nick": (5, String(_))} }, new_connection_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [], uint64: [], regex: [] }, fields: {"tls": (0, Boolean(_)), "ip": (0, Ip(_))} }, pre_sasl_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [""], uint64: [], regex: [] }, fields: {"mechanism": (0, String(_)), "tls": (0, Boolean(_)), "ip": (0, Ip(_))} } }, audit_log: {}, accounts: {}, nick_registrations: {}, channel_registrations: {}, channel_accesses: {}, channel_roles: {}, current_services: None, current_history_server_id: None, config: NetworkConfig { opers: [OperConfig { name: "operuser", hash: "$6$z5yA.OfGliDoi/R2$BgSsguS6bxAsPSCygDisgDw5JZuo5.88eU3Hyc7/4OaNpeKIxWGjOggeHzOl0xLiZg1vfwxXjOTFN14wG5vNI." }], debug_mode: true, default_roles: {BuiltinAll: ChannelAccessSet(1114112), BuiltinVoice: ChannelAccessSet(4296081441), BuiltinOp: ChannelAccessSet(222192934775)}, alias_users: [AliasUser { nick: Nickname("ChanServ"), user: Username("ChanServ"), host: Hostname("services."), realname: Realname("Channel services compatibility layer"), command_alias: "CS" }, AliasUser { nick: Nickname("NickServ"), user: Username("NickServ"), host: Hostname("services."), realname: Realname("Account services compatibility layer"), command_alias: "NS" }], object_expiry: 60, pingout_duration: 600 }, clock: EventClock(1 => 826011240957480962), cache_default_channel_roles: OnceLock(), alias_users: OnceLock() }) } 1774773227.399 sable_services #x1B[2m2026-03-29T08:33:47.399376Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Server 1774773227.400 sable_services #x1B[2m2026-03-29T08:33:47.399476Z#x1B[0m #x1B[33m WARN#x1B[0m #x1B[2msable_services::database::jsonfile#x1B[0m#x1B[2m:#x1B[0m Couldn't open database file, starting from empty 1774773227.400 sable_services #x1B[2m2026-03-29T08:33:47.399941Z#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(826011245185740800)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Services"), ts: 1774773227, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 826011240957480962) my clock=EventClock(1 => 826011240957480962) 1774773227.400 sable_services #x1B[2m2026-03-29T08:33:47.400333Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245185740800)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Services"), ts: 1774773227, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773227.402 sable_services #x1B[2m2026-03-29T08:33:47.402049Z#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(826011245198323713)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245185740800), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774773227 }) }; event clock=EventClock(1 => 826011240957480962, 99 => 826011245185740800) my clock=EventClock(1 => 826011240957480962, 99 => 826011245185740800) 1774773227.403 sable_services #x1B[2m2026-03-29T08:33:47.402376Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245198323713)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245185740800), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774773227 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773227.403 sable_services #x1B[2m2026-03-29T08:33:47.402468Z#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(826011245185740800)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Services"), ts: 1774773227, 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(99) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Services 1774773227.406 sable_services #x1B[2m2026-03-29T08:33:47.405936Z#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(826011245210906626)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245198323713), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 826011240957480962, 99 => 826011245198323713) my clock=EventClock(1 => 826011240957480962, 99 => 826011245198323713) 1774773227.407 sable_services #x1B[2m2026-03-29T08:33:47.406210Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245210906626)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245198323713), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773227.407 sable_ircd #x1B[2m2026-03-29T08:33:47.406829Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245198323713)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245185740800), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774773227 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(826011245198323713)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245185740800), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774773227 }) }; event clock=EventClock(1 => 826011240957480962, 99 => 826011245185740800) my clock=EventClock(1 => 826011240957480962) 1774773227.407 sable_ircd #x1B[2m2026-03-29T08:33:47.406898Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245198323713)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245185740800), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774773227 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(826011245185740800))] 1774773227.407 sable_ircd #x1B[2m2026-03-29T08:33:47.406947Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245198323713)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245185740800), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774773227 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1774773227.443 sable_ircd #x1B[2m2026-03-29T08:33:47.442930Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245185740800)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Services"), ts: 1774773227, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(826011245185740800)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Services"), ts: 1774773227, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 826011240957480962) my clock=EventClock(1 => 826011240957480962) 1774773227.443 sable_ircd #x1B[2m2026-03-29T08:33:47.443014Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245185740800)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Services"), ts: 1774773227, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(826011245198323713)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245185740800), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774773227 }) } 1774773227.443 sable_ircd #x1B[2m2026-03-29T08:33:47.443080Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245185740800)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Services"), ts: 1774773227, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1774773227.443 sable_ircd #x1B[2m2026-03-29T08:33:47.443368Z#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(826011245185740800)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774773226, name: ServerName("My.Little.Services"), ts: 1774773227, 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(99) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Services 1774773227.444 sable_ircd #x1B[2m2026-03-29T08:33:47.443590Z#x1B[0m #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(826011245185740800)), timestamp: 1774773227, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }) 1774773227.444 sable_ircd #x1B[2m2026-03-29T08:33:47.443663Z#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(826011245185740800)), timestamp: 1774773227, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] } 1774773227.444 sable_ircd #x1B[2m2026-03-29T08:33:47.443721Z#x1B[0m #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(826011245185740800)), timestamp: 1774773227, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773227.444 sable_ircd #x1B[2m2026-03-29T08:33:47.443743Z#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(826011245185740800)), timestamp: 1774773227, change: EventComplete(EventComplete), users_to_notify: [] } 1774773227.444 sable_ircd #x1B[2m2026-03-29T08:33:47.443773Z#x1B[0m #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(826011245198323713)), timestamp: 1774773227, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773227.444 sable_ircd #x1B[2m2026-03-29T08:33:47.443794Z#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(826011245198323713)), timestamp: 1774773227, change: EventComplete(EventComplete), users_to_notify: [] } 1774773227.448 sable_services #x1B[2m2026-03-29T08:33:47.447831Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: GetEvent([EventId(Snowflake(826011245185740800))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(826011245185740800))] 1774773227.448 sable_services #x1B[2m2026-03-29T08:33:47.447868Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: GetEvent([EventId(Snowflake(826011245185740800))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [] 1774773227.449 sable_ircd #x1B[2m2026-03-29T08:33:47.448876Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245210906626)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245198323713), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(826011245210906626)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245198323713), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 826011240957480962, 99 => 826011245198323713) my clock=EventClock(1 => 826011240957480962, 99 => 826011245198323713) 1774773227.449 sable_ircd #x1B[2m2026-03-29T08:33:47.449177Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245210906626)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245198323713), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011245210906626)), timestamp: 1774773227, clock: EventClock(1 => 826011240957480962, 99 => 826011245198323713), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773227.453 sable_ircd #x1B[2m2026-03-29T08:33:47.452618Z#x1B[0m #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(826011245210906626)), timestamp: 1774773227, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }) 1774773227.453 sable_ircd #x1B[2m2026-03-29T08:33:47.452682Z#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(826011245210906626)), timestamp: 1774773227, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] } 1774773227.453 sable_ircd #x1B[2m2026-03-29T08:33:47.452796Z#x1B[0m #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(826011245210906626)), timestamp: 1774773227, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773227.453 sable_ircd #x1B[2m2026-03-29T08:33:47.452836Z#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(826011245210906626)), timestamp: 1774773227, change: EventComplete(EventComplete), users_to_notify: [] } 1774773227.489 sable_ircd #x1B[2m2026-03-29T08:33:47.488853Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: BulkEvents([]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [] 1774773228.096 chkSvs: waiting… 1774773228.206 sable_ircd #x1B[2m2026-03-29T08:33:48.205882Z#x1B[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 :synchronize530.810025051 1774773228.206 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize530.810025051 1774773228.206 chkSvs -> S: CAP LS 302 1774773228.207 sable_ircd #x1B[2m2026-03-29T08:33:48.206725Z#x1B[0m #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 1774773228.207 sable_ircd #x1B[2m2026-03-29T08:33:48.206786Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP LS 302" 1774773228.257 chkSvs -> S: PING synchronize532.474911367 1774773228.257 sable_ircd #x1B[2m2026-03-29T08:33:48.257002Z#x1B[0m #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 1774773228.257 sable_ircd #x1B[2m2026-03-29T08:33:48.257081Z#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 synchronize532.474911367" 1774773229.011 sable_ircd #x1B[2m2026-03-29T08:33:49.010985Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1774773229.011 S -> chkSvs: :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1774773230.013 chkSvs: waiting… 1774773230.016 sable_ircd #x1B[2m2026-03-29T08:33:50.015525Z#x1B[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 :synchronize532.474911367 1774773230.016 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize532.474911367 1774773230.016 chkSvs -> S: QUIT 1774773230.016 chkSvs -> S: PING synchronize534.234531979 1774773230.017 sable_ircd #x1B[2m2026-03-29T08:33:50.016484Z#x1B[0m #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 1774773230.017 sable_ircd #x1B[2m2026-03-29T08:33:50.016538Z#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"QUIT" 1774773230.017 sable_ircd #x1B[2m2026-03-29T08:33:50.016625Z#x1B[0m #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 1774773230.017 sable_ircd #x1B[2m2026-03-29T08:33:50.016701Z#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 synchronize534.234531979" 1774773231.017 chkSvs: waiting… 1774773231.021 sable_ircd #x1B[2m2026-03-29T08:33:51.021091Z#x1B[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): ERROR :Client quit 1774773231.022 sable_ircd #x1B[2m2026-03-29T08:33:51.021247Z#x1B[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), 2)) 1774773231.022 sable_ircd #x1B[2m2026-03-29T08:33:51.021291Z#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), 2) 1774773231.022 sable_ircd #x1B[2m2026-03-29T08:33:51.021433Z#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(826011260377108483)), timestamp: 1774773231, clock: EventClock(1 => 826011240957480962, 99 => 826011245210906626), target: UserConnection(UserConnectionId(Snowflake(826011240957480961))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 826011240957480962, 99 => 826011245210906626) my clock=EventClock(1 => 826011240957480962, 99 => 826011245210906626) 1774773231.022 sable_ircd #x1B[2m2026-03-29T08:33:51.021754Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260377108483)), timestamp: 1774773231, clock: EventClock(1 => 826011240957480962, 99 => 826011245210906626), target: UserConnection(UserConnectionId(Snowflake(826011240957480961))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773231.024 S -> chkSvs: ERROR :Client quit 1774773231.024 chkSvs: disconnects from server. 1774773231.024 1: connects to server. 1774773231.024 1 -> S: NICK foo 1774773231.024 1 -> S: USER r e g :user 1774773231.025 sable_ircd #x1B[2m2026-03-29T08:33:51.024860Z#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(826011260389691396)), timestamp: 1774773231, clock: EventClock(1 => 826011260377108483, 99 => 826011245210906626), target: User(UserId(Snowflake(826011240957480960))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 826011260377108483, 99 => 826011245210906626) my clock=EventClock(1 => 826011260377108483, 99 => 826011245210906626) 1774773231.026 sable_ircd #x1B[2m2026-03-29T08:33:51.025199Z#x1B[0m #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(826011260377108483)), timestamp: 1774773231, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(826011240957480960)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(826011240957480961)), user: UserId(Snowflake(826011240957480960)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773226 } }), users_to_notify: [] }) 1774773231.026 sable_ircd #x1B[2m2026-03-29T08:33:51.025238Z#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(826011260377108483)), timestamp: 1774773231, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(826011240957480960)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(826011240957480961)), user: UserId(Snowflake(826011240957480960)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773226 } }), users_to_notify: [] } 1774773231.026 sable_ircd #x1B[2m2026-03-29T08:33:51.025305Z#x1B[0m #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(826011260377108483)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773231.026 sable_ircd #x1B[2m2026-03-29T08:33:51.025313Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260389691396)), timestamp: 1774773231, clock: EventClock(1 => 826011260377108483, 99 => 826011245210906626), target: User(UserId(Snowflake(826011240957480960))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773231.026 sable_ircd #x1B[2m2026-03-29T08:33:51.025336Z#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(826011260377108483)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] } 1774773231.028 sable_ircd #x1B[2m2026-03-29T08:33:51.027833Z#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), 2) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed 1774773231.028 sable_ircd #x1B[2m2026-03-29T08:33:51.027906Z#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 } 1774773231.028 sable_ircd #x1B[2m2026-03-29T08:33:51.028000Z#x1B[0m #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 1774773231.028 sable_ircd #x1B[2m2026-03-29T08:33:51.028088Z#x1B[0m #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 1774773231.028 sable_ircd #x1B[2m2026-03-29T08:33:51.028124Z#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 1774773231.028 sable_ircd #x1B[2m2026-03-29T08:33:51.028173Z#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 1774773231.028 sable_ircd #x1B[2m2026-03-29T08:33:51.028290Z#x1B[0m #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 1774773231.028 sable_ircd #x1B[2m2026-03-29T08:33:51.028328Z#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 foo" 1774773231.028 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1774773231.029 sable_ircd #x1B[2m2026-03-29T08:33:51.028480Z#x1B[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: 535, tv_nsec: 246530533 }, 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 1774773231.029 sable_ircd #x1B[2m2026-03-29T08:33:51.028553Z#x1B[0m #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 1774773231.029 sable_ircd #x1B[2m2026-03-29T08:33:51.028599Z#x1B[0m #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 1774773231.029 sable_ircd #x1B[2m2026-03-29T08:33:51.028664Z#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 r e g :user" 1774773231.029 sable_services #x1B[2m2026-03-29T08:33:51.028741Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260377108483)), timestamp: 1774773231, clock: EventClock(1 => 826011240957480962, 99 => 826011245210906626), target: UserConnection(UserConnectionId(Snowflake(826011240957480961))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(826011260377108483)), timestamp: 1774773231, clock: EventClock(1 => 826011240957480962, 99 => 826011245210906626), target: UserConnection(UserConnectionId(Snowflake(826011240957480961))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 826011240957480962, 99 => 826011245210906626) my clock=EventClock(1 => 826011240957480962, 99 => 826011245210906626) 1774773231.029 sable_ircd #x1B[2m2026-03-29T08:33:51.028748Z#x1B[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: 535, tv_nsec: 246530533 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("foo")), realname: OnceLock(Realname("user")), 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 1774773231.029 sable_ircd #x1B[2m2026-03-29T08:33:51.029408Z#x1B[0m #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 1774773231.029 sable_ircd #x1B[2m2026-03-29T08:33:51.029441Z#x1B[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")) 1774773231.030 sable_ircd #x1B[2m2026-03-29T08:33:51.029480Z#x1B[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 1774773231.030 sable_ircd #x1B[2m2026-03-29T08:33:51.029513Z#x1B[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: 535, tv_nsec: 246530533 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("foo")), realname: OnceLock(Realname("user")), 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 1774773231.030 sable_services #x1B[2m2026-03-29T08:33:51.029146Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260377108483)), timestamp: 1774773231, clock: EventClock(1 => 826011240957480962, 99 => 826011245210906626), target: UserConnection(UserConnectionId(Snowflake(826011240957480961))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260377108483)), timestamp: 1774773231, clock: EventClock(1 => 826011240957480962, 99 => 826011245210906626), target: UserConnection(UserConnectionId(Snowflake(826011240957480961))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773231.030 sable_ircd #x1B[2m2026-03-29T08:33:51.029570Z#x1B[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)) 1774773231.030 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1774773231.033 sable_ircd #x1B[2m2026-03-29T08:33:51.032490Z#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(826011260423245829)), timestamp: 1774773231, clock: EventClock(1 => 826011260389691396, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(826011260410662915)), NewUserConnection { user: UserId(Snowflake(826011260410662914)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773231 })) }) }; event clock=EventClock(1 => 826011260389691396, 99 => 826011245210906626) my clock=EventClock(1 => 826011260389691396, 99 => 826011245210906626) 1774773231.033 sable_ircd #x1B[2m2026-03-29T08:33:51.032945Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260423245829)), timestamp: 1774773231, clock: EventClock(1 => 826011260389691396, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(826011260410662915)), NewUserConnection { user: UserId(Snowflake(826011260410662914)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773231 })) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773231.033 sable_ircd #x1B[2m2026-03-29T08:33:51.033076Z#x1B[0m #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(826011260389691396)), timestamp: 1774773231, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(826011240957480960)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1774773231.033 sable_ircd #x1B[2m2026-03-29T08:33:51.033142Z#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(826011260389691396)), timestamp: 1774773231, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(826011240957480960)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1774773231.033 sable_ircd #x1B[2m2026-03-29T08:33:51.033221Z#x1B[0m #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(826011260389691396)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773231.033 sable_ircd #x1B[2m2026-03-29T08:33:51.033251Z#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(826011260389691396)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] } 1774773231.034 sable_services #x1B[2m2026-03-29T08:33:51.033459Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260389691396)), timestamp: 1774773231, clock: EventClock(1 => 826011260377108483, 99 => 826011245210906626), target: User(UserId(Snowflake(826011240957480960))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(826011260389691396)), timestamp: 1774773231, clock: EventClock(1 => 826011260377108483, 99 => 826011245210906626), target: User(UserId(Snowflake(826011240957480960))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 826011260377108483, 99 => 826011245210906626) my clock=EventClock(1 => 826011260377108483, 99 => 826011245210906626) 1774773231.035 sable_services #x1B[2m2026-03-29T08:33:51.034688Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260389691396)), timestamp: 1774773231, clock: EventClock(1 => 826011260377108483, 99 => 826011245210906626), target: User(UserId(Snowflake(826011240957480960))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260389691396)), timestamp: 1774773231, clock: EventClock(1 => 826011260377108483, 99 => 826011245210906626), target: User(UserId(Snowflake(826011240957480960))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.035937Z#x1B[0m #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(826011260423245829)), timestamp: 1774773231, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 1) }), users_to_notify: [] }) 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.035980Z#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(826011260423245829)), timestamp: 1774773231, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 1) }), users_to_notify: [] } 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036057Z#x1B[0m #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(826011260423245829)), timestamp: 1774773231, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 2), connection: UserConnectionId(Snowflake(826011260410662915)) }), users_to_notify: [] }) 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036096Z#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(826011260423245829)), timestamp: 1774773231, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 2), connection: UserConnectionId(Snowflake(826011260410662915)) }), users_to_notify: [] } 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036163Z#x1B[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 foo :Welcome to the test Internet Relay Chat network, foo 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036206Z#x1B[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 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036242Z#x1B[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 foo :This server was created 2026-03-29 08:33:51.036230714 UTC 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036274Z#x1B[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 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036308Z#x1B[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 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 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036324Z#x1B[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 foo :MOTD File is missing 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036338Z#x1B[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!r@localhost MODE foo + 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036349Z#x1B[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 foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036380Z#x1B[0m #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(826011260423245829)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773231.037 sable_ircd #x1B[2m2026-03-29T08:33:51.036396Z#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(826011260423245829)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] } 1774773231.037 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo 1774773231.077 sable_services #x1B[2m2026-03-29T08:33:51.077149Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260423245829)), timestamp: 1774773231, clock: EventClock(1 => 826011260389691396, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(826011260410662915)), NewUserConnection { user: UserId(Snowflake(826011260410662914)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773231 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(826011260423245829)), timestamp: 1774773231, clock: EventClock(1 => 826011260389691396, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(826011260410662915)), NewUserConnection { user: UserId(Snowflake(826011260410662914)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773231 })) }) }; event clock=EventClock(1 => 826011260389691396, 99 => 826011245210906626) my clock=EventClock(1 => 826011260389691396, 99 => 826011245210906626) 1774773231.078 sable_services #x1B[2m2026-03-29T08:33:51.077595Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260423245829)), timestamp: 1774773231, clock: EventClock(1 => 826011260389691396, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(826011260410662915)), NewUserConnection { user: UserId(Snowflake(826011260410662914)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773231 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011260423245829)), timestamp: 1774773231, clock: EventClock(1 => 826011260389691396, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(826011260410662915)), NewUserConnection { user: UserId(Snowflake(826011260410662914)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773231 })) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773231.137 1 -> S: PING synchronize535.35527948 1774773231.137 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1774773231.137 S -> 1: :My.Little.Server 003 foo :This server was created 2026-03-29 08:33:51.036230714 UTC 1774773231.137 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1774773231.137 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 1774773231.137 S -> 1: :My.Little.Server 422 foo :MOTD File is missing 1774773231.137 S -> 1: :foo!r@localhost MODE foo + 1774773231.137 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1774773231.137 sable_ircd #x1B[2m2026-03-29T08:33:51.137336Z#x1B[0m #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 1774773231.137 sable_ircd #x1B[2m2026-03-29T08:33:51.137383Z#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 synchronize535.35527948" 1774773231.137 sable_ircd #x1B[2m2026-03-29T08:33:51.137466Z#x1B[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 :synchronize535.35527948 1774773231.138 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize535.35527948 1774773231.138 1 -> S: REGISTER * * barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar 1774773231.138 sable_ircd #x1B[2m2026-03-29T08:33:51.138030Z#x1B[0m #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 1774773231.138 sable_ircd #x1B[2m2026-03-29T08:33:51.138068Z#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"REGISTER * * barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar" 1774773231.138 sable_ircd #x1B[2m2026-03-29T08:33:51.138247Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Found target peer, sending message #x1B[3mtarget#x1B[0m#x1B[2m=#x1B[0mPeerConfig { name: ServerName("My.Little.Services"), address: "127.0.0.1:42031", fingerprint: "e3e3e9081dc3c176bbdca643a5da2325c9b710b0" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("foo"), "barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar")) } 1774773231.138 sable_ircd #x1B[2m2026-03-29T08:33:51.138425Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("foo"), "barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar")) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773231.141 sable_ircd #x1B[2m2026-03-29T08:33:51.140472Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(26) }) 1774773231.181 sable_services #x1B[2m2026-03-29T08:33:51.180989Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(RegisterUser(Nickname("foo"), "barbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbarbar")) 1774773231.181 sable_services #x1B[2m2026-03-29T08:33:51.181024Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got register request #x1B[3maccount_name#x1B[0m#x1B[2m=#x1B[0mNickname("foo") 1774773231.185 sable_services #x1B[2m2026-03-29T08:33:51.184844Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server::command::user_commands#x1B[0m#x1B[2m:#x1B[0m Successfully created account #x1B[3mnew_account#x1B[0m#x1B[2m=#x1B[0mAccount { id: AccountId(Snowflake(826011261048598528)), name: Nickname("foo"), authorised_fingerprints: [] } 1774773231.185 sable_services #x1B[2m2026-03-29T08:33:51.185036Z#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(826011261065375747)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: Account(AccountId(Snowflake(826011261048598528))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(826011261048598528)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 826011260423245829, 99 => 826011245210906626) my clock=EventClock(1 => 826011260423245829, 99 => 826011245210906626) 1774773231.185 sable_services #x1B[2m2026-03-29T08:33:51.185371Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011261065375747)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: Account(AccountId(Snowflake(826011261048598528))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(826011261048598528)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773231.226 sable_ircd #x1B[2m2026-03-29T08:33:51.225835Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got targeted message response #x1B[3mresponse#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: TargetedMessageResponse(Services(LogUserIn(AccountId(Snowflake(826011261048598528))))) } } 1774773231.226 sable_ircd #x1B[2m2026-03-29T08:33:51.226018Z#x1B[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): REGISTER SUCCESS foo :You have successfully registered 1774773231.226 sable_ircd #x1B[2m2026-03-29T08:33:51.226071Z#x1B[0m #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 1774773231.226 sable_ircd #x1B[2m2026-03-29T08:33:51.226119Z#x1B[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[0mStateChange(User(UserId(Snowflake(826011260410662914))), UserLogin(UserLogin { account: Some(AccountId(Snowflake(826011261048598528))) })) 1774773231.226 sable_ircd #x1B[2m2026-03-29T08:33:51.226243Z#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(826011261236940806)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(826011261048598528))) }) }; event clock=EventClock(1 => 826011260423245829, 99 => 826011245210906626) my clock=EventClock(1 => 826011260423245829, 99 => 826011245210906626) 1774773231.227 sable_ircd #x1B[2m2026-03-29T08:33:51.226511Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011261236940806)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(826011261048598528))) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773231.228 sable_ircd #x1B[2m2026-03-29T08:33:51.228277Z#x1B[0m #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(826011261236940806)), timestamp: 1774773231, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 3), old_account: None, new_account: Some(AccountId(Snowflake(826011261048598528))) }), users_to_notify: [] }) 1774773231.228 sable_ircd #x1B[2m2026-03-29T08:33:51.228322Z#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(826011261236940806)), timestamp: 1774773231, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 3), old_account: None, new_account: Some(AccountId(Snowflake(826011261048598528))) }), users_to_notify: [] } 1774773231.228 sable_ircd #x1B[2m2026-03-29T08:33:51.228388Z#x1B[0m #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(826011261236940806)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773231.228 sable_ircd #x1B[2m2026-03-29T08:33:51.228419Z#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(826011261236940806)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] } 1774773231.229 sable_ircd #x1B[2m2026-03-29T08:33:51.228881Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011261065375747)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: Account(AccountId(Snowflake(826011261048598528))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(826011261048598528)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(826011261065375747)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: Account(AccountId(Snowflake(826011261048598528))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(826011261048598528)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 826011260423245829, 99 => 826011245210906626) my clock=EventClock(1 => 826011261236940806, 99 => 826011245210906626) 1774773231.229 sable_ircd #x1B[2m2026-03-29T08:33:51.229148Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011261065375747)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: Account(AccountId(Snowflake(826011261048598528))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(826011261048598528)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011261065375747)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: Account(AccountId(Snowflake(826011261048598528))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(826011261048598528)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773231.231 sable_ircd #x1B[2m2026-03-29T08:33:51.230894Z#x1B[0m #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(826011261065375747)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773231.231 sable_ircd #x1B[2m2026-03-29T08:33:51.230932Z#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(826011261065375747)), timestamp: 1774773231, change: EventComplete(EventComplete), users_to_notify: [] } 1774773231.269 sable_services #x1B[2m2026-03-29T08:33:51.268910Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011261236940806)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(826011261048598528))) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(826011261236940806)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(826011261048598528))) }) }; event clock=EventClock(1 => 826011260423245829, 99 => 826011245210906626) my clock=EventClock(1 => 826011260423245829, 99 => 826011261065375747) 1774773231.269 sable_services #x1B[2m2026-03-29T08:33:51.269247Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011261236940806)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(826011261048598528))) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011261236940806)), timestamp: 1774773231, clock: EventClock(1 => 826011260423245829, 99 => 826011245210906626), target: User(UserId(Snowflake(826011260410662914))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(826011261048598528))) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773231.338 1 -> S: PING synchronize535.556358622 1774773231.338 S -> 1: REGISTER SUCCESS foo :You have successfully registered 1774773231.338 sable_ircd #x1B[2m2026-03-29T08:33:51.338387Z#x1B[0m #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 1774773231.338 sable_ircd #x1B[2m2026-03-29T08:33:51.338439Z#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 synchronize535.556358622" 1774773232.092 sable_ircd #x1B[2m2026-03-29T08:33:52.092312Z#x1B[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 :synchronize535.556358622 1774773232.093 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize535.556358622 1774773232.093 1 -> S: QUIT 1774773232.093 sable_ircd #x1B[2m2026-03-29T08:33:52.093040Z#x1B[0m #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 1774773232.093 sable_ircd #x1B[2m2026-03-29T08:33:52.093081Z#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"QUIT" 1774773232.193 1 -> S: PING synchronize536.411234444 1774773232.193 sable_ircd #x1B[2m2026-03-29T08:33:52.193264Z#x1B[0m #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 1774773232.193 sable_ircd #x1B[2m2026-03-29T08:33:52.193313Z#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 synchronize536.411234444" 1774773233.194 1: waiting… 1774773233.199 sable_ircd #x1B[2m2026-03-29T08:33:53.198799Z#x1B[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): ERROR :Client quit 1774773233.199 sable_ircd #x1B[2m2026-03-29T08:33:53.198921Z#x1B[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), 3)) 1774773233.199 sable_ircd #x1B[2m2026-03-29T08:33:53.198961Z#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), 3) 1774773233.199 S -> 1: ERROR :Client quit 1774773233.199 sable_ircd #x1B[2m2026-03-29T08:33:53.199118Z#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(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 826011261236940806, 99 => 826011261065375747) my clock=EventClock(1 => 826011261236940806, 99 => 826011261065375747) 1774773233.199 sable_ircd #x1B[2m2026-03-29T08:33:53.199386Z#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), 3) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed 1774773233.200 sable_ircd #x1B[2m2026-03-29T08:33:53.199473Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773233.200 sable_ircd #x1B[2m2026-03-29T08:33:53.199484Z#x1B[0m #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 1774773233.201 sable_ircd #x1B[2m2026-03-29T08:33:53.201207Z#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(826011269520691208)), timestamp: 1774773233, clock: EventClock(1 => 826011269512302599, 99 => 826011261065375747), target: User(UserId(Snowflake(826011260410662914))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 826011269512302599, 99 => 826011261065375747) my clock=EventClock(1 => 826011269512302599, 99 => 826011261065375747) 1774773233.202 sable_ircd #x1B[2m2026-03-29T08:33:53.201455Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269520691208)), timestamp: 1774773233, clock: EventClock(1 => 826011269512302599, 99 => 826011261065375747), target: User(UserId(Snowflake(826011260410662914))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773233.202 sable_ircd #x1B[2m2026-03-29T08:33:53.201567Z#x1B[0m #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(826011269512302599)), timestamp: 1774773233, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(826011260410662915)), user: UserId(Snowflake(826011260410662914)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773231 } }), users_to_notify: [] }) 1774773233.202 sable_ircd #x1B[2m2026-03-29T08:33:53.201605Z#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(826011269512302599)), timestamp: 1774773233, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(826011260410662915)), user: UserId(Snowflake(826011260410662914)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774773231 } }), users_to_notify: [] } 1774773233.202 sable_ircd #x1B[2m2026-03-29T08:33:53.201676Z#x1B[0m #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(826011269512302599)), timestamp: 1774773233, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773233.202 sable_ircd #x1B[2m2026-03-29T08:33:53.201701Z#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(826011269512302599)), timestamp: 1774773233, change: EventComplete(EventComplete), users_to_notify: [] } 1774773233.205 sable_ircd #x1B[2m2026-03-29T08:33:53.205061Z#x1B[0m #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(826011269520691208)), timestamp: 1774773233, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 3), nickname: Nickname("foo"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1774773233.205 sable_ircd #x1B[2m2026-03-29T08:33:53.205106Z#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(826011269520691208)), timestamp: 1774773233, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(826011260410662914)), 3), nickname: Nickname("foo"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1774773233.205 sable_ircd #x1B[2m2026-03-29T08:33:53.205172Z#x1B[0m #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(826011269520691208)), timestamp: 1774773233, change: EventComplete(EventComplete), users_to_notify: [] }) 1774773233.205 sable_ircd #x1B[2m2026-03-29T08:33:53.205211Z#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(826011269520691208)), timestamp: 1774773233, change: EventComplete(EventComplete), users_to_notify: [] } 1774773233.206 sable_services #x1B[2m2026-03-29T08:33:53.205706Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269520691208)), timestamp: 1774773233, clock: EventClock(1 => 826011269512302599, 99 => 826011261065375747), target: User(UserId(Snowflake(826011260410662914))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(826011269520691208)), timestamp: 1774773233, clock: EventClock(1 => 826011269512302599, 99 => 826011261065375747), target: User(UserId(Snowflake(826011260410662914))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 826011269512302599, 99 => 826011261065375747) my clock=EventClock(1 => 826011261236940806, 99 => 826011261065375747) 1774773233.206 sable_services #x1B[2m2026-03-29T08:33:53.205772Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269520691208)), timestamp: 1774773233, clock: EventClock(1 => 826011269512302599, 99 => 826011261065375747), target: User(UserId(Snowflake(826011260410662914))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(826011269512302599))] 1774773233.206 sable_services #x1B[2m2026-03-29T08:33:53.206042Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269520691208)), timestamp: 1774773233, clock: EventClock(1 => 826011269512302599, 99 => 826011261065375747), target: User(UserId(Snowflake(826011260410662914))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269520691208)), timestamp: 1774773233, clock: EventClock(1 => 826011269512302599, 99 => 826011261065375747), target: User(UserId(Snowflake(826011260410662914))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773233.242 sable_services #x1B[2m2026-03-29T08:33:53.241920Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 826011261236940806, 99 => 826011261065375747) my clock=EventClock(1 => 826011261236940806, 99 => 826011261065375747) 1774773233.242 sable_services #x1B[2m2026-03-29T08:33:53.241978Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(826011269520691208)), timestamp: 1774773233, clock: EventClock(1 => 826011269512302599, 99 => 826011261065375747), target: User(UserId(Snowflake(826011260410662914))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1774773233.242 sable_services #x1B[2m2026-03-29T08:33:53.242219Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1774773226), content: NewEvent(Event { id: EventId(Snowflake(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:60805 (127.0.0.1:60805) 1774773233.247 sable_ircd #x1B[2m2026-03-29T08:33:53.246852Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: GetEvent([EventId(Snowflake(826011269512302599))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(826011269512302599))] 1774773233.247 sable_ircd #x1B[2m2026-03-29T08:33:53.246901Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: GetEvent([EventId(Snowflake(826011269512302599))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }] 1774773233.289 sable_services #x1B[2m2026-03-29T08:33:53.288908Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1774773226), content: BulkEvents([Event { id: EventId(Snowflake(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(826011269512302599)), timestamp: 1774773233, clock: EventClock(1 => 826011261236940806, 99 => 826011261065375747), target: UserConnection(UserConnectionId(Snowflake(826011260410662915))), details: UserDisconnect(UserDisconnect) }] 1774773233.299 1 -> S: PING synchronize537.517694095 1774773233.300 1: connects to server. 1774773233.300 1 -> S: CAP LS 302 1774773233.300 sable_ircd #x1B[2m2026-03-29T08:33:53.300037Z#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 } 1774773233.300 sable_ircd #x1B[2m2026-03-29T08:33:53.300154Z#x1B[0m #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 1774773233.300 sable_ircd #x1B[2m2026-03-29T08:33:53.300202Z#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 1774773233.300 sable_ircd #x1B[2m2026-03-29T08:33:53.300260Z#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 1774773233.300 sable_ircd #x1B[2m2026-03-29T08:33:53.300384Z#x1B[0m #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 1774773233.301 sable_ircd #x1B[2m2026-03-29T08:33:53.300438Z#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"CAP LS 302" 1774773233.301 sable_ircd #x1B[2m2026-03-29T08:33:53.300522Z#x1B[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 CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1774773233.301 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1774773233.301 S -> 1: :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1774773233.301 1 -> S: CAP REQ :sasl 1774773233.301 sable_ircd #x1B[2m2026-03-29T08:33:53.301084Z#x1B[0m #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 1774773233.301 sable_ircd #x1B[2m2026-03-29T08:33:53.301119Z#x1B[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")) 1774773233.301 sable_ircd #x1B[2m2026-03-29T08:33:53.301143Z#x1B[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 1774773233.301 sable_ircd #x1B[2m2026-03-29T08:33:53.301164Z#x1B[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: 537, tv_nsec: 518615097 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1774773233.301 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1774773233.301 sable_ircd #x1B[2m2026-03-29T08:33:53.301372Z#x1B[0m #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 1774773233.301 sable_ircd #x1B[2m2026-03-29T08:33:53.301426Z#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"CAP REQ :sasl" 1774773233.302 sable_ircd #x1B[2m2026-03-29T08:33:53.301547Z#x1B[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 CAP * ACK :sasl 1774773233.302 sable_ircd #x1B[2m2026-03-29T08:33:53.301587Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mUpdateConnectionCaps(ConnectionId(ListenerId(0), 4), ClientCapabilitySet(8)) 1774773233.342 S -> 1: :My.Little.Server CAP * ACK :sasl 1774773233.342 1 -> S: AUTHENTICATE PLAIN 1774773233.342 sable_ircd #x1B[2m2026-03-29T08:33:53.342110Z#x1B[0m #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 1774773233.342 sable_ircd #x1B[2m2026-03-29T08:33:53.342166Z#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"AUTHENTICATE PLAIN" 1774773233.342 sable_ircd #x1B[2m2026-03-29T08:33:53.342335Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::command::handlers::services::sasl#x1B[0m#x1B[2m:#x1B[0m Beginning new SASL session #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(826011270112088068)) 1774773233.343 sable_ircd #x1B[2m2026-03-29T08:33:53.342483Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Found target peer, sending message #x1B[3mtarget#x1B[0m#x1B[2m=#x1B[0mPeerConfig { name: ServerName("My.Little.Services"), address: "127.0.0.1:42031", fingerprint: "e3e3e9081dc3c176bbdca643a5da2325c9b710b0" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(826011270112088068)), "PLAIN")) } 1774773233.343 sable_ircd #x1B[2m2026-03-29T08:33:53.342793Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(826011270112088068)), "PLAIN")) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773233.345 sable_ircd #x1B[2m2026-03-29T08:33:53.344487Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(35) }) 1774773233.387 sable_services #x1B[2m2026-03-29T08:33:53.386119Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(BeginAuthenticate(SaslSessionId(Snowflake(826011270112088068)), "PLAIN")) 1774773233.387 sable_services #x1B[2m2026-03-29T08:33:53.386179Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got begin authenticate #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(826011270112088068)) #x1B[3mmechanism#x1B[0m#x1B[2m=#x1B[0m"PLAIN" 1774773233.427 sable_ircd #x1B[2m2026-03-29T08:33:53.426923Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got targeted message response #x1B[3mresponse#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: TargetedMessageResponse(Services(Authenticate(InProgress([])))) } } 1774773233.427 sable_ircd #x1B[2m2026-03-29T08:33:53.427129Z#x1B[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): AUTHENTICATE :+ 1774773233.427 sable_ircd #x1B[2m2026-03-29T08:33:53.427198Z#x1B[0m #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 1774773233.428 S -> 1: AUTHENTICATE :+ 1774773233.428 1 -> S: AUTHENTICATE Zm9vAGZvbwBiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJi 1774773233.428 1 -> S: AUTHENTICATE YXJiYXJiYXI= 1774773233.428 sable_ircd #x1B[2m2026-03-29T08:33:53.427868Z#x1B[0m #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 1774773233.428 sable_ircd #x1B[2m2026-03-29T08:33:53.427922Z#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"AUTHENTICATE Zm9vAGZvbwBiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJiYXJi" 1774773233.428 sable_ircd #x1B[2m2026-03-29T08:33:53.428081Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::command::handlers::services::sasl#x1B[0m#x1B[2m:#x1B[0m Resuming SASL session #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(826011270112088068)) 1774773233.428 sable_ircd #x1B[2m2026-03-29T08:33:53.428164Z#x1B[0m #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 1774773233.428 sable_ircd #x1B[2m2026-03-29T08:33:53.428210Z#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"AUTHENTICATE YXJiYXJiYXI=" 1774773233.428 sable_ircd #x1B[2m2026-03-29T08:33:53.428361Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Found target peer, sending message #x1B[3mtarget#x1B[0m#x1B[2m=#x1B[0mPeerConfig { name: ServerName("My.Little.Services"), address: "127.0.0.1:42031", fingerprint: "e3e3e9081dc3c176bbdca643a5da2325c9b710b0" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(Authenticate(SaslSessionId(Snowflake(826011270112088068)), [102, 111, 111, 0, 102, 111, 111, 0, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98])) } 1774773233.429 sable_ircd #x1B[2m2026-03-29T08:33:53.428658Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774773226), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(Authenticate(SaslSessionId(Snowflake(826011270112088068)), [102, 111, 111, 0, 102, 111, 111, 0, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98])) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:42031 (127.0.0.1:42031) 1774773233.430 sable_ircd #x1B[2m2026-03-29T08:33:53.430370Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(36) }) 1774773233.472 sable_services #x1B[2m2026-03-29T08:33:53.472107Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(Authenticate(SaslSessionId(Snowflake(826011270112088068)), [102, 111, 111, 0, 102, 111, 111, 0, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98])) 1774773233.472 sable_services #x1B[2m2026-03-29T08:33:53.472188Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got authenticate data #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(826011270112088068)) #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0m[102, 111, 111, 0, 102, 111, 111, 0, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98, 97, 114, 98] 1774773233.476 sable_services #x1B[2m2026-03-29T08:33:53.476011Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server::sasl::plain#x1B[0m#x1B[2m:#x1B[0m sasl login successful #x1B[3maccount_name#x1B[0m#x1B[2m=#x1B[0mNickname("foo") 1774773233.517 sable_ircd #x1B[2m2026-03-29T08:33:53.516846Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got targeted message response #x1B[3mresponse#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1774773226), content: TargetedMessageResponse(Services(Authenticate(Success(AccountId(Snowflake(826011261048598528)))))) } } 1774773233.517 sable_ircd #x1B[2m2026-03-29T08:33:53.517014Z#x1B[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 900 * * foo :You are now logged in as foo 1774773233.517 sable_ircd #x1B[2m2026-03-29T08:33:53.517059Z#x1B[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 903 * :SASL authentication successful 1774773233.517 sable_ircd #x1B[2m2026-03-29T08:33:53.517094Z#x1B[0m #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 1774773233.517 S -> 1: :My.Little.Server 900 * * foo :You are now logged in as foo 1774773233.558 S -> 1: :My.Little.Server 903 * :SASL authentication successful 1774773233.560 sable_ircd #x1B[2m2026-03-29T08:33:53.560167Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error in outbound network sync connection: I/O error: unexpected end of file 1774773233.561 sable_ircd #x1B[2m2026-03-29T08:33:53.560382Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1mhandle_connection#x1B[0m#x1B[1m{#x1B[0m#x1B[3mconn#x1B[0m#x1B[2m=#x1B[0mPollEvented { io: Some(TcpStream { addr: 127.0.0.1:60805, peer: 127.0.0.1:49835, fd: 19 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x55ca3982c090, tail_position: 0 }, semaphore: Semaphore(0), rx_waker: AtomicWaker, tx_count: 2, rx_fields: "..." } } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error handling message: I/O error: unexpected end of file 1774773233.561 sable_ircd #x1B[2m2026-03-29T08:33:53.560410Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error in outbound network sync connection: I/O error: unexpected end of file 1774773233.561 sable_ircd #x1B[2m2026-03-29T08:33:53.560410Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error in outbound network sync connection: I/O error: unexpected end of file 1774773233.563 1: disconnects from server.