--------------------------------- Captured Out ---------------------------------
---- new test ----
1772747482.865 sable_ircd     uid=1001
1772747482.866 sable_services uid=1001
1772747482.867 sable_services #x1B[2m2026-03-05T21:51:22.867084Z#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:48549", fingerprint: "8a7ed04f2d52090ebbcdda392b0cc9390d2dec55" }
1772747482.867 sable_services #x1B[2m2026-03-05T21:51:22.867387Z#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), 1772747482), 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:48549. Last error: I/O error: Connection refused (os error 111)
1772747482.868 sable_services #x1B[2m2026-03-05T21:51:22.867510Z#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), 1772747482), 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)
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.869456Z#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(817514656800182272)), timestamp: 1772747482, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Server"), ts: 1772747482, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.869587Z#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
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.869813Z#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(817514656800182272)), timestamp: 1772747482, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Server"), ts: 1772747482, 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
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.869924Z#x1B[0m #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
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.870044Z#x1B[0m #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(817514656800182272)), timestamp: 1772747482, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.870102Z#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(817514656800182272)), timestamp: 1772747482, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.870173Z#x1B[0m #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(817514656800182272)), timestamp: 1772747482, change: EventComplete(EventComplete), users_to_notify: [] })
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.870206Z#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(817514656800182272)), timestamp: 1772747482, change: EventComplete(EventComplete), users_to_notify: [] }
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.870317Z#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(817514656804376577)), timestamp: 1772747482, clock: EventClock(1 => 817514656800182272), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1772747482 }) }; event clock=EventClock(1 => 817514656800182272) my clock=EventClock(1 => 817514656800182272)
1772747482.870 sable_ircd     #x1B[2m2026-03-05T21:51:22.870414Z#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
1772747482.871 sable_ircd     #x1B[2m2026-03-05T21:51:22.870669Z#x1B[0m #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(817514656804376577)), timestamp: 1772747482, change: EventComplete(EventComplete), users_to_notify: [] })
1772747482.871 sable_ircd     #x1B[2m2026-03-05T21:51:22.870701Z#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(817514656804376577)), timestamp: 1772747482, change: EventComplete(EventComplete), users_to_notify: [] }
1772747482.961 sable_ircd     #x1B[2m2026-03-05T21:51:22.961419Z#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 }
1772747482.962 sable_ircd     #x1B[2m2026-03-05T21:51:22.961564Z#x1B[0m #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
1772747482.962 sable_ircd     #x1B[2m2026-03-05T21:51:22.961612Z#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
1772747482.962 sable_ircd     #x1B[2m2026-03-05T21:51:22.961677Z#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
1772747482.962 sable_ircd     #x1B[2m2026-03-05T21:51:22.961816Z#x1B[0m #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
1772747482.962 sable_ircd     #x1B[2m2026-03-05T21:51:22.961886Z#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"
1772747482.962 sable_ircd     #x1B[2m2026-03-05T21:51:22.962011Z#x1B[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
1772747482.962 sable_ircd     #x1B[2m2026-03-05T21:51:22.962120Z#x1B[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))
1772747482.962 sable_ircd     #x1B[2m2026-03-05T21:51:22.962159Z#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)
1772747482.963 sable_ircd     #x1B[2m2026-03-05T21:51:22.962616Z#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
1772747482.963 sable_ircd     #x1B[2m2026-03-05T21:51:22.962717Z#x1B[0m #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
1772747482.963 sable_ircd     #x1B[2m2026-03-05T21:51:22.962899Z#x1B[0m #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
1772747482.983 chkSvs: connects to server.
1772747482.983 chkSvs -> S: NICK chkSvs
1772747482.983 chkSvs -> S: USER chk chk chk chk
1772747482.983 sable_ircd     #x1B[2m2026-03-05T21:51:22.982929Z#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 }
1772747482.983 sable_ircd     #x1B[2m2026-03-05T21:51:22.983099Z#x1B[0m #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
1772747482.983 sable_ircd     #x1B[2m2026-03-05T21:51:22.983163Z#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
1772747482.983 sable_ircd     #x1B[2m2026-03-05T21:51:22.983245Z#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
1772747482.984 sable_ircd     #x1B[2m2026-03-05T21:51:22.983453Z#x1B[0m #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
1772747482.984 sable_ircd     #x1B[2m2026-03-05T21:51:22.983525Z#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"
1772747482.984 sable_ircd     #x1B[2m2026-03-05T21:51:22.983730Z#x1B[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: 320, tv_nsec: 319883496 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(<uninit>), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747482.984 sable_ircd     #x1B[2m2026-03-05T21:51:22.983804Z#x1B[0m #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
1772747482.984 sable_ircd     #x1B[2m2026-03-05T21:51:22.983875Z#x1B[0m #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
1772747482.984 sable_ircd     #x1B[2m2026-03-05T21:51:22.983925Z#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"
1772747482.984 sable_ircd     #x1B[2m2026-03-05T21:51:22.984021Z#x1B[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: 320, tv_nsec: 319883496 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747482.985 sable_ircd     #x1B[2m2026-03-05T21:51:22.984539Z#x1B[0m #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
1772747482.985 sable_ircd     #x1B[2m2026-03-05T21:51:22.984590Z#x1B[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"))
1772747482.985 sable_ircd     #x1B[2m2026-03-05T21:51:22.984640Z#x1B[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
1772747482.985 sable_ircd     #x1B[2m2026-03-05T21:51:22.984683Z#x1B[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: 320, tv_nsec: 319883496 }, attach_user_id: OnceLock(<uninit>), 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(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747482.985 sable_ircd     #x1B[2m2026-03-05T21:51:22.984745Z#x1B[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))
1772747482.985 sable_ircd     #x1B[2m2026-03-05T21:51:22.985000Z#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(817514657282527234)), timestamp: 1772747482, clock: EventClock(1 => 817514656804376577), target: User(UserId(Snowflake(817514657282527232))), 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(817514657282527233)), NewUserConnection { user: UserId(Snowflake(817514657282527232)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747482 })) }) }; event clock=EventClock(1 => 817514656804376577) my clock=EventClock(1 => 817514656804376577)
1772747482.985 sable_ircd     #x1B[2m2026-03-05T21:51:22.985112Z#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
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985462Z#x1B[0m #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(817514657282527234)), timestamp: 1772747482, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514657282527232)), 1) }), users_to_notify: [] })
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985503Z#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(817514657282527234)), timestamp: 1772747482, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514657282527232)), 1) }), users_to_notify: [] }
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985549Z#x1B[0m #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(817514657282527234)), timestamp: 1772747482, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514657282527232)), 2), connection: UserConnectionId(Snowflake(817514657282527233)) }), users_to_notify: [] })
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985572Z#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(817514657282527234)), timestamp: 1772747482, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514657282527232)), 2), connection: UserConnectionId(Snowflake(817514657282527233)) }), users_to_notify: [] }
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985620Z#x1B[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
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985648Z#x1B[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
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985668Z#x1B[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-05 21:51:22.985661126 UTC
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985686Z#x1B[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
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985721Z#x1B[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
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985742Z#x1B[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
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985758Z#x1B[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 +
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985770Z#x1B[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.
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985793Z#x1B[0m #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(817514657282527234)), timestamp: 1772747482, change: EventComplete(EventComplete), users_to_notify: [] })
1772747482.986 sable_ircd     #x1B[2m2026-03-05T21:51:22.985812Z#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(817514657282527234)), timestamp: 1772747482, change: EventComplete(EventComplete), users_to_notify: [] }
1772747482.986 sable_services #x1B[2m2026-03-05T21:51:22.986099Z#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:48549", fingerprint: "8a7ed04f2d52090ebbcdda392b0cc9390d2dec55" }
1772747482.986 sable_services #x1B[2m2026-03-05T21:51:22.986378Z#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), 1772747482), 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:48549. Last error: I/O error: Connection refused (os error 111)
1772747482.986 sable_services #x1B[2m2026-03-05T21:51:22.986421Z#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), 1772747482), 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)
1772747483.070 sable_services #x1B[2m2026-03-05T21:51:23.069896Z#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:60969", fingerprint: "24c02a0c9f607ed28cd8456d2eda56ff1765d729" } (attempt #3).
1772747483.070 sable_services #x1B[2m2026-03-05T21:51:23.069942Z#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.
1772747483.070 sable_services #x1B[2m2026-03-05T21:51:23.070154Z#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), 1772747482), 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:60969 (127.0.0.1:60969)
1772747483.075 sable_ircd     #x1B[2m2026-03-05T21:51:23.074790Z#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
1772747483.083 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname
1772747483.083 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1772747483.083 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs
1772747483.083 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747483.083 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2026-03-05 21:51:22.985661126 UTC
1772747483.083 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747483.083 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
1772747483.083 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing
1772747483.083 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs +
1772747483.083 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747483.083 chkSvs -> S: CAP LS 302
1772747483.083 sable_ircd     #x1B[2m2026-03-05T21:51:23.083398Z#x1B[0m #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
1772747483.083 sable_ircd     #x1B[2m2026-03-05T21:51:23.083452Z#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"
1772747483.084 sable_ircd     #x1B[2m2026-03-05T21:51:23.083571Z#x1B[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
1772747483.116 sable_services #x1B[2m2026-03-05T21:51:23.116041Z#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), 1772747482), content: NetworkState(Network { nick_bindings: {Nickname("chkSvs"): NickBinding { nick: Nickname("chkSvs"), user: UserId(Snowflake(817514657282527232)), timestamp: 1772747482, created: EventId(Snowflake(817514657282527234)) }}, historic_nick_users: HistoricNickStore { data: {} }, users: {UserId(Snowflake(817514657282527232)): User { id: UserId(Snowflake(817514657282527232)), 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(817514657282527232)), 1): HistoricUser { id: UserId(Snowflake(817514657282527232)), serial: 1, nickname: Nickname("chkSvs"), user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, account: None, timestamp: Some(1772747482) }, HistoricUserId(UserId(Snowflake(817514657282527232)), 2): HistoricUser { id: UserId(Snowflake(817514657282527232)), 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(817514657282527233)): UserConnection { id: UserConnectionId(Snowflake(817514657282527233)), user: UserId(Snowflake(817514657282527232)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747482 }}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1772747482, name: ServerName("My.Little.Server"), last_ping: 1772747482, 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(_)), "host": (4, String(_)), "nick": (2, String(_)), "user": (0, String(_)), "user_param_1": (1, String(_)), "realname": (5, String(_)), "user_param_2": (3, String(_)), "tls": (0, Boolean(_))} }, 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: {"tls": (0, Boolean(_)), "mechanism": (0, String(_)), "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: {BuiltinVoice: ChannelAccessSet(4296081441), BuiltinOp: ChannelAccessSet(222192934775), BuiltinAll: ChannelAccessSet(1114112)}, 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 => 817514657282527234), cache_default_channel_roles: OnceLock(<uninit>), alias_users: OnceLock(<uninit>) }) }
1772747483.116 sable_services #x1B[2m2026-03-05T21:51:23.116262Z#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
1772747483.116 sable_services #x1B[2m2026-03-05T21:51:23.116420Z#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
1772747483.117 sable_services #x1B[2m2026-03-05T21:51:23.116958Z#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(817514657836576768)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Services"), ts: 1772747483, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 817514657282527234) my clock=EventClock(1 => 817514657282527234)
1772747483.117 sable_services #x1B[2m2026-03-05T21:51:23.117424Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657836576768)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Services"), ts: 1772747483, 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:60969 (127.0.0.1:60969)
1772747483.120 sable_services #x1B[2m2026-03-05T21:51:23.119271Z#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(817514657849159681)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657836576768), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747483 }) }; event clock=EventClock(1 => 817514657282527234, 99 => 817514657836576768) my clock=EventClock(1 => 817514657282527234, 99 => 817514657836576768)
1772747483.120 sable_services #x1B[2m2026-03-05T21:51:23.119591Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657849159681)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657836576768), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747483 }) }) } #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:60969 (127.0.0.1:60969)
1772747483.120 sable_services #x1B[2m2026-03-05T21:51:23.119693Z#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(817514657836576768)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Services"), ts: 1772747483, 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
1772747483.123 sable_services #x1B[2m2026-03-05T21:51:23.123043Z#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(817514657865936898)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657849159681), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 817514657282527234, 99 => 817514657849159681) my clock=EventClock(1 => 817514657282527234, 99 => 817514657849159681)
1772747483.124 sable_services #x1B[2m2026-03-05T21:51:23.123321Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657865936898)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657849159681), 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:60969 (127.0.0.1:60969)
1772747483.124 sable_ircd     #x1B[2m2026-03-05T21:51:23.124073Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657849159681)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657836576768), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747483 }) }) } }#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(817514657849159681)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657836576768), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747483 }) }; event clock=EventClock(1 => 817514657282527234, 99 => 817514657836576768) my clock=EventClock(1 => 817514657282527234)
1772747483.124 sable_ircd     #x1B[2m2026-03-05T21:51:23.124163Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657849159681)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657836576768), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747483 }) }) } }#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(817514657836576768))]
1772747483.124 sable_ircd     #x1B[2m2026-03-05T21:51:23.124204Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657849159681)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657836576768), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747483 }) }) } }#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
1772747483.133 chkSvs -> S: PING synchronize320.469722413
1772747483.133 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
1772747483.134 sable_ircd     #x1B[2m2026-03-05T21:51:23.133469Z#x1B[0m #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
1772747483.134 sable_ircd     #x1B[2m2026-03-05T21:51:23.133521Z#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 synchronize320.469722413"
1772747483.134 sable_ircd     #x1B[2m2026-03-05T21:51:23.133626Z#x1B[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 :synchronize320.469722413
1772747483.134 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize320.469722413
1772747483.134 chkSvs -> S: CAP LS 302
1772747483.134 sable_ircd     #x1B[2m2026-03-05T21:51:23.134269Z#x1B[0m #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
1772747483.134 sable_ircd     #x1B[2m2026-03-05T21:51:23.134309Z#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"
1772747483.134 sable_ircd     #x1B[2m2026-03-05T21:51:23.134433Z#x1B[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
1772747483.161 sable_ircd     #x1B[2m2026-03-05T21:51:23.160777Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657836576768)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Services"), ts: 1772747483, 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(817514657836576768)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Services"), ts: 1772747483, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 817514657282527234) my clock=EventClock(1 => 817514657282527234)
1772747483.161 sable_ircd     #x1B[2m2026-03-05T21:51:23.160855Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657836576768)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Services"), ts: 1772747483, 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(817514657849159681)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657836576768), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747483 }) }
1772747483.161 sable_ircd     #x1B[2m2026-03-05T21:51:23.160910Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657836576768)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Services"), ts: 1772747483, 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
1772747483.161 sable_ircd     #x1B[2m2026-03-05T21:51:23.161159Z#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(817514657836576768)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747482, name: ServerName("My.Little.Services"), ts: 1772747483, 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
1772747483.161 sable_ircd     #x1B[2m2026-03-05T21:51:23.161320Z#x1B[0m #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(817514657836576768)), timestamp: 1772747483, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] })
1772747483.161 sable_ircd     #x1B[2m2026-03-05T21:51:23.161386Z#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(817514657836576768)), timestamp: 1772747483, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }
1772747483.162 sable_ircd     #x1B[2m2026-03-05T21:51:23.161459Z#x1B[0m #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(817514657836576768)), timestamp: 1772747483, change: EventComplete(EventComplete), users_to_notify: [] })
1772747483.162 sable_ircd     #x1B[2m2026-03-05T21:51:23.161492Z#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(817514657836576768)), timestamp: 1772747483, change: EventComplete(EventComplete), users_to_notify: [] }
1772747483.162 sable_ircd     #x1B[2m2026-03-05T21:51:23.161543Z#x1B[0m #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(817514657849159681)), timestamp: 1772747483, change: EventComplete(EventComplete), users_to_notify: [] })
1772747483.162 sable_ircd     #x1B[2m2026-03-05T21:51:23.161572Z#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(817514657849159681)), timestamp: 1772747483, change: EventComplete(EventComplete), users_to_notify: [] }
1772747483.166 sable_services #x1B[2m2026-03-05T21:51:23.165579Z#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), 1772747482), content: GetEvent([EventId(Snowflake(817514657836576768))]) } }#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(817514657836576768))]
1772747483.166 sable_services #x1B[2m2026-03-05T21:51:23.165623Z#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), 1772747482), content: GetEvent([EventId(Snowflake(817514657836576768))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events []
1772747483.168 sable_ircd     #x1B[2m2026-03-05T21:51:23.167644Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657865936898)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657849159681), 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(817514657865936898)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657849159681), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 817514657282527234, 99 => 817514657849159681) my clock=EventClock(1 => 817514657282527234, 99 => 817514657849159681)
1772747483.168 sable_ircd     #x1B[2m2026-03-05T21:51:23.168000Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657865936898)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657849159681), 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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514657865936898)), timestamp: 1772747483, clock: EventClock(1 => 817514657282527234, 99 => 817514657849159681), 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:57073 (127.0.0.1:57073)
1772747483.172 sable_ircd     #x1B[2m2026-03-05T21:51:23.171614Z#x1B[0m #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(817514657865936898)), timestamp: 1772747483, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] })
1772747483.172 sable_ircd     #x1B[2m2026-03-05T21:51:23.171657Z#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(817514657865936898)), timestamp: 1772747483, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }
1772747483.172 sable_ircd     #x1B[2m2026-03-05T21:51:23.171761Z#x1B[0m #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(817514657865936898)), timestamp: 1772747483, change: EventComplete(EventComplete), users_to_notify: [] })
1772747483.172 sable_ircd     #x1B[2m2026-03-05T21:51:23.171799Z#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(817514657865936898)), timestamp: 1772747483, change: EventComplete(EventComplete), users_to_notify: [] }
1772747483.184 chkSvs -> S: PING synchronize320.520758479
1772747483.184 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
1772747483.185 sable_ircd     #x1B[2m2026-03-05T21:51:23.184505Z#x1B[0m #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
1772747483.185 sable_ircd     #x1B[2m2026-03-05T21:51:23.184548Z#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 synchronize320.520758479"
1772747483.207 sable_ircd     #x1B[2m2026-03-05T21:51:23.206620Z#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), 1772747482), 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: []
1772747484.185 chkSvs: waiting…
1772747484.188 sable_ircd     #x1B[2m2026-03-05T21:51:24.188093Z#x1B[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 :synchronize320.520758479
1772747484.188 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize320.520758479
1772747484.189 chkSvs -> S: CAP LS 302
1772747484.189 sable_ircd     #x1B[2m2026-03-05T21:51:24.188882Z#x1B[0m #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
1772747484.189 sable_ircd     #x1B[2m2026-03-05T21:51:24.188933Z#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"
1772747484.239 chkSvs -> S: PING synchronize321.575368483
1772747484.239 sable_ircd     #x1B[2m2026-03-05T21:51:24.239097Z#x1B[0m #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
1772747484.239 sable_ircd     #x1B[2m2026-03-05T21:51:24.239145Z#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 synchronize321.575368483"
1772747485.240 chkSvs: waiting…
1772747485.245 sable_ircd     #x1B[2m2026-03-05T21:51:25.244523Z#x1B[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
1772747485.245 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
1772747485.250 sable_history  #x1B[2m2027-03-05T21:58:56.356651Z#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(949788129806721034)), timestamp: 1804283936, clock: EventClock(1 => 949786103294988289, 50 => 949787878148481033), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283936 }) }; event clock=EventClock(1 => 949786103294988289, 50 => 949787878148481033) my clock=EventClock(1 => 949786103294988289, 50 => 949787878148481033)
1772747485.250 sable_history  #x1B[2m2027-03-05T21:58:56.362238Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788129806721034)), timestamp: 1804283936, clock: EventClock(1 => 949786103294988289, 50 => 949787878148481033), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283936 }) }) } #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:58223. Last error: I/O error: Connection refused (os error 111)
1772747485.250 sable_history  #x1B[2m2027-03-05T21:58:56.362881Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788129806721034)), timestamp: 1804283936, clock: EventClock(1 => 949786103294988289, 50 => 949787878148481033), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283936 }) }) } #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)
1772747485.250 sable_history  #x1B[2m2027-03-05T21:58:56.363351Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111)
1772747485.686 sable_history  #x1B[2m2027-03-05T21:58:56.592069Z#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(949788130792382474)), timestamp: 1804283936, clock: EventClock(1 => 949786183724961807, 50 => 949787879134142473, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283936 }) }; event clock=EventClock(1 => 949786183724961807, 50 => 949787879134142473, 99 => 949786173562564612) my clock=EventClock(1 => 949786183724961807, 50 => 949787879134142473, 99 => 949786173562564612)
1772747485.686 sable_history  #x1B[2m2027-03-05T21:58:56.599718Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788130792382474)), timestamp: 1804283936, clock: EventClock(1 => 949786183724961807, 50 => 949787879134142473, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283936 }) }) } #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 Could not connect to 127.0.0.1:37225. Last error: I/O error: Connection refused (os error 111)
1772747485.686 sable_history  #x1B[2m2027-03-05T21:58:56.600455Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788130792382474)), timestamp: 1804283936, clock: EventClock(1 => 949786183724961807, 50 => 949787879134142473, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283936 }) }) } #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 #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111)
1772747485.686 sable_history  #x1B[2m2027-03-05T21:58:56.601323Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111)
1772747485.686 sable_history  #x1B[2m2027-03-05T21:58:56.602177Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788130792382474)), timestamp: 1804283936, clock: EventClock(1 => 949786183724961807, 50 => 949787879134142473, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283936 }) }) } #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:44627. Last error: I/O error: Connection refused (os error 111)
1772747485.686 sable_history  #x1B[2m2027-03-05T21:58:56.602769Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788130792382474)), timestamp: 1804283936, clock: EventClock(1 => 949786183724961807, 50 => 949787879134142473, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283936 }) }) } #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)
1772747485.686 sable_history  #x1B[2m2027-03-05T21:58:56.603922Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111)
1772747486.246 chkSvs: waiting…
1772747486.248 sable_ircd     #x1B[2m2026-03-05T21:51:26.247981Z#x1B[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 :synchronize321.575368483
1772747486.248 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize321.575368483
1772747486.249 chkSvs -> S: QUIT
1772747486.249 chkSvs -> S: PING synchronize323.58520621
1772747486.249 sable_ircd     #x1B[2m2026-03-05T21:51:26.248835Z#x1B[0m #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
1772747486.249 sable_ircd     #x1B[2m2026-03-05T21:51:26.248903Z#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"
1772747486.249 sable_ircd     #x1B[2m2026-03-05T21:51:26.248993Z#x1B[0m #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
1772747486.249 sable_ircd     #x1B[2m2026-03-05T21:51:26.249043Z#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 synchronize323.58520621"
1772747487.004 sable_ircd     #x1B[2m2026-03-05T21:51:27.003834Z#x1B[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
1772747487.004 sable_ircd     #x1B[2m2026-03-05T21:51:27.004023Z#x1B[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))
1772747487.004 sable_ircd     #x1B[2m2026-03-05T21:51:27.004070Z#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)
1772747487.004 sable_ircd     #x1B[2m2026-03-05T21:51:27.004177Z#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(817514674143629315)), timestamp: 1772747487, clock: EventClock(1 => 817514657282527234, 99 => 817514657865936898), target: UserConnection(UserConnectionId(Snowflake(817514657282527233))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 817514657282527234, 99 => 817514657865936898) my clock=EventClock(1 => 817514657282527234, 99 => 817514657865936898)
1772747487.004 S -> chkSvs: ERROR :Client quit
1772747487.005 chkSvs: disconnects from server.
1772747487.005 1: connects to server.
1772747487.005 1 -> S: NICK bob
1772747487.005 1 -> S: USER r e g :user
1772747487.005 sable_ircd     #x1B[2m2026-03-05T21:51:27.004617Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674143629315)), timestamp: 1772747487, clock: EventClock(1 => 817514657282527234, 99 => 817514657865936898), target: UserConnection(UserConnectionId(Snowflake(817514657282527233))), 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:57073 (127.0.0.1:57073)
1772747487.005 sable_ircd     #x1B[2m2026-03-05T21:51:27.004767Z#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
1772747487.005 sable_ircd     #x1B[2m2026-03-05T21:51:27.004876Z#x1B[0m #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
1772747487.005 sable_ircd     #x1B[2m2026-03-05T21:51:27.005376Z#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 }
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.005470Z#x1B[0m #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
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.005530Z#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
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.005597Z#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
1772747487.006 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.005804Z#x1B[0m #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
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.005852Z#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 bob"
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.005979Z#x1B[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: 324, tv_nsec: 342242862 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("bob")), realname: OnceLock(<uninit>), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.006037Z#x1B[0m #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
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.006076Z#x1B[0m #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
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.006108Z#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"
1772747487.006 sable_ircd     #x1B[2m2026-03-05T21:51:27.006181Z#x1B[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: 324, tv_nsec: 342242862 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("bob")), realname: OnceLock(Realname("user")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747487.007 sable_ircd     #x1B[2m2026-03-05T21:51:27.006517Z#x1B[0m #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
1772747487.007 sable_ircd     #x1B[2m2026-03-05T21:51:27.006555Z#x1B[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"))
1772747487.007 sable_ircd     #x1B[2m2026-03-05T21:51:27.006606Z#x1B[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
1772747487.007 sable_ircd     #x1B[2m2026-03-05T21:51:27.006649Z#x1B[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: 324, tv_nsec: 342242862 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("bob")), realname: OnceLock(Realname("user")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747487.007 sable_ircd     #x1B[2m2026-03-05T21:51:27.006712Z#x1B[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))
1772747487.007 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1772747487.007 sable_ircd     #x1B[2m2026-03-05T21:51:27.007102Z#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(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 817514674143629315, 99 => 817514657865936898) my clock=EventClock(1 => 817514674143629315, 99 => 817514657865936898)
1772747487.007 sable_ircd     #x1B[2m2026-03-05T21:51:27.007442Z#x1B[0m #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(817514674143629315)), timestamp: 1772747487, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(817514657282527232)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(817514657282527233)), user: UserId(Snowflake(817514657282527232)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747482 } }), users_to_notify: [] })
1772747487.008 sable_ircd     #x1B[2m2026-03-05T21:51:27.007487Z#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(817514674143629315)), timestamp: 1772747487, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(817514657282527232)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(817514657282527233)), user: UserId(Snowflake(817514657282527232)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747482 } }), users_to_notify: [] }
1772747487.008 sable_ircd     #x1B[2m2026-03-05T21:51:27.007570Z#x1B[0m #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(817514674143629315)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] })
1772747487.008 sable_ircd     #x1B[2m2026-03-05T21:51:27.007610Z#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(817514674143629315)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] }
1772747487.008 sable_ircd     #x1B[2m2026-03-05T21:51:27.007614Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), 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:57073 (127.0.0.1:57073)
1772747487.009 sable_ircd     #x1B[2m2026-03-05T21:51:27.009301Z#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(817514674164600837)), timestamp: 1772747487, clock: EventClock(1 => 817514674156212228, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: NewUser(NewUser { nickname: Nickname("bob"), 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(817514674152017923)), NewUserConnection { user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 })) }) }; event clock=EventClock(1 => 817514674156212228, 99 => 817514657865936898) my clock=EventClock(1 => 817514674156212228, 99 => 817514657865936898)
1772747487.010 sable_ircd     #x1B[2m2026-03-05T21:51:27.009639Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674164600837)), timestamp: 1772747487, clock: EventClock(1 => 817514674156212228, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: NewUser(NewUser { nickname: Nickname("bob"), 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(817514674152017923)), NewUserConnection { user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 })) }) }) } #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:57073 (127.0.0.1:57073)
1772747487.010 sable_ircd     #x1B[2m2026-03-05T21:51:27.009803Z#x1B[0m #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(817514674156212228)), timestamp: 1772747487, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(817514657282527232)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] })
1772747487.010 sable_ircd     #x1B[2m2026-03-05T21:51:27.009844Z#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(817514674156212228)), timestamp: 1772747487, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(817514657282527232)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }
1772747487.010 sable_ircd     #x1B[2m2026-03-05T21:51:27.009924Z#x1B[0m #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(817514674156212228)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] })
1772747487.010 sable_ircd     #x1B[2m2026-03-05T21:51:27.009967Z#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(817514674156212228)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] }
1772747487.013 sable_ircd     #x1B[2m2026-03-05T21:51:27.013255Z#x1B[0m #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(817514674164600837)), timestamp: 1772747487, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 1) }), users_to_notify: [] })
1772747487.013 sable_ircd     #x1B[2m2026-03-05T21:51:27.013297Z#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(817514674164600837)), timestamp: 1772747487, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 1) }), users_to_notify: [] }
1772747487.013 sable_ircd     #x1B[2m2026-03-05T21:51:27.013373Z#x1B[0m #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(817514674164600837)), timestamp: 1772747487, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 2), connection: UserConnectionId(Snowflake(817514674152017923)) }), users_to_notify: [] })
1772747487.013 sable_ircd     #x1B[2m2026-03-05T21:51:27.013416Z#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(817514674164600837)), timestamp: 1772747487, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 2), connection: UserConnectionId(Snowflake(817514674152017923)) }), users_to_notify: [] }
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013490Z#x1B[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 bob :Welcome to the test Internet Relay Chat network, bob
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013537Z#x1B[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 bob :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013589Z#x1B[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 bob :This server was created 2026-03-05 21:51:27.013571928 UTC
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013678Z#x1B[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 bob My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013726Z#x1B[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 bob 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
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013755Z#x1B[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 bob :MOTD File is missing
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013781Z#x1B[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): :bob!r@localhost MODE bob +
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013803Z#x1B[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 bob :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013843Z#x1B[0m #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(817514674164600837)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] })
1772747487.014 sable_ircd     #x1B[2m2026-03-05T21:51:27.013869Z#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(817514674164600837)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] }
1772747487.014 S -> 1: :My.Little.Server 001 bob :Welcome to the test Internet Relay Chat network, bob
1772747487.014 sable_services #x1B[2m2026-03-05T21:51:27.014157Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674164600837)), timestamp: 1772747487, clock: EventClock(1 => 817514674156212228, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: NewUser(NewUser { nickname: Nickname("bob"), 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(817514674152017923)), NewUserConnection { user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 })) }) }) } }#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(817514674164600837)), timestamp: 1772747487, clock: EventClock(1 => 817514674156212228, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: NewUser(NewUser { nickname: Nickname("bob"), 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(817514674152017923)), NewUserConnection { user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 })) }) }; event clock=EventClock(1 => 817514674156212228, 99 => 817514657865936898) my clock=EventClock(1 => 817514657282527234, 99 => 817514657865936898)
1772747487.014 sable_services #x1B[2m2026-03-05T21:51:27.014284Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674164600837)), timestamp: 1772747487, clock: EventClock(1 => 817514674156212228, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: NewUser(NewUser { nickname: Nickname("bob"), 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(817514674152017923)), NewUserConnection { user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 })) }) }) } }#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(817514674156212228))]
1772747487.015 sable_services #x1B[2m2026-03-05T21:51:27.014758Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674164600837)), timestamp: 1772747487, clock: EventClock(1 => 817514674156212228, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: NewUser(NewUser { nickname: Nickname("bob"), 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(817514674152017923)), NewUserConnection { user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 })) }) }) } }#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674164600837)), timestamp: 1772747487, clock: EventClock(1 => 817514674156212228, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: NewUser(NewUser { nickname: Nickname("bob"), 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(817514674152017923)), NewUserConnection { user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 })) }) }) } #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:60969 (127.0.0.1:60969)
1772747487.048 sable_services #x1B[2m2026-03-05T21:51:27.047821Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674143629315)), timestamp: 1772747487, clock: EventClock(1 => 817514657282527234, 99 => 817514657865936898), target: UserConnection(UserConnectionId(Snowflake(817514657282527233))), 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(817514674143629315)), timestamp: 1772747487, clock: EventClock(1 => 817514657282527234, 99 => 817514657865936898), target: UserConnection(UserConnectionId(Snowflake(817514657282527233))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 817514657282527234, 99 => 817514657865936898) my clock=EventClock(1 => 817514657282527234, 99 => 817514657865936898)
1772747487.048 sable_services #x1B[2m2026-03-05T21:51:27.048376Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674143629315)), timestamp: 1772747487, clock: EventClock(1 => 817514657282527234, 99 => 817514657865936898), target: UserConnection(UserConnectionId(Snowflake(817514657282527233))), 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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674143629315)), timestamp: 1772747487, clock: EventClock(1 => 817514657282527234, 99 => 817514657865936898), target: UserConnection(UserConnectionId(Snowflake(817514657282527233))), 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:60969 (127.0.0.1:60969)
1772747487.051 sable_services #x1B[2m2026-03-05T21:51:27.051083Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), 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(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 817514674143629315, 99 => 817514657865936898) my clock=EventClock(1 => 817514674143629315, 99 => 817514657865936898)
1772747487.051 sable_services #x1B[2m2026-03-05T21:51:27.051157Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), 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 satisfied deferred event Event { id: EventId(Snowflake(817514674164600837)), timestamp: 1772747487, clock: EventClock(1 => 817514674156212228, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: NewUser(NewUser { nickname: Nickname("bob"), 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(817514674152017923)), NewUserConnection { user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 })) }) }
1772747487.051 sable_services #x1B[2m2026-03-05T21:51:27.051394Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), 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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), 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:60969 (127.0.0.1:60969)
1772747487.057 sable_ircd     #x1B[2m2026-03-05T21:51:27.056539Z#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), 1772747482), content: GetEvent([EventId(Snowflake(817514674156212228))]) } }#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(817514674156212228))]
1772747487.057 sable_ircd     #x1B[2m2026-03-05T21:51:27.056591Z#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), 1772747482), content: GetEvent([EventId(Snowflake(817514674156212228))]) } }#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(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), details: UserQuit(UserQuit { message: "Client Quit" }) }]
1772747487.098 sable_services #x1B[2m2026-03-05T21:51:27.097611Z#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), 1772747482), content: BulkEvents([Event { id: EventId(Snowflake(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), details: UserQuit(UserQuit { message: "Client Quit" }) }]) } }#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(817514674156212228)), timestamp: 1772747487, clock: EventClock(1 => 817514674143629315, 99 => 817514657865936898), target: User(UserId(Snowflake(817514657282527232))), details: UserQuit(UserQuit { message: "Client Quit" }) }]
1772747487.114 1 -> S: PING synchronize324.451028353
1772747487.114 S -> 1: :My.Little.Server 002 bob :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747487.114 S -> 1: :My.Little.Server 003 bob :This server was created 2026-03-05 21:51:27.013571928 UTC
1772747487.114 S -> 1: :My.Little.Server 004 bob My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747487.115 S -> 1: :My.Little.Server 005 bob 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
1772747487.115 S -> 1: :My.Little.Server 422 bob :MOTD File is missing
1772747487.115 S -> 1: :bob!r@localhost MODE bob +
1772747487.115 S -> 1: :My.Little.Server NOTICE bob :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747487.115 sable_ircd     #x1B[2m2026-03-05T21:51:27.114841Z#x1B[0m #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
1772747487.115 sable_ircd     #x1B[2m2026-03-05T21:51:27.114914Z#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 synchronize324.451028353"
1772747487.115 sable_ircd     #x1B[2m2026-03-05T21:51:27.115066Z#x1B[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 :synchronize324.451028353
1772747487.115 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize324.451028353
1772747487.116 1 -> S: REGISTER * * sesame
1772747487.116 sable_ircd     #x1B[2m2026-03-05T21:51:27.115782Z#x1B[0m #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
1772747487.116 sable_ircd     #x1B[2m2026-03-05T21:51:27.115836Z#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 * * sesame"
1772747487.116 sable_ircd     #x1B[2m2026-03-05T21:51:27.116056Z#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:57073", fingerprint: "8d46af24b25bf6cfe24dfa16d294021330f76dc6" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("bob"), "sesame")) }
1772747487.116 sable_ircd     #x1B[2m2026-03-05T21:51:27.116311Z#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), 1772747482), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("bob"), "sesame")) }) } #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:57073 (127.0.0.1:57073)
1772747487.118 sable_ircd     #x1B[2m2026-03-05T21:51:27.118148Z#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) })
1772747487.160 sable_services #x1B[2m2026-03-05T21:51:27.159857Z#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("bob"), "sesame"))
1772747487.160 sable_services #x1B[2m2026-03-05T21:51:27.159904Z#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("bob")
1772747487.164 sable_services #x1B[2m2026-03-05T21:51:27.163793Z#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(817514674794147840)), name: Nickname("bob"), authorised_fingerprints: [] }
1772747487.164 sable_services #x1B[2m2026-03-05T21:51:27.164009Z#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(817514674810925059)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: Account(AccountId(Snowflake(817514674794147840))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817514674794147840)), name: Nickname("bob"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 817514674164600837, 99 => 817514657865936898) my clock=EventClock(1 => 817514674164600837, 99 => 817514657865936898)
1772747487.164 sable_services #x1B[2m2026-03-05T21:51:27.164315Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674810925059)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: Account(AccountId(Snowflake(817514674794147840))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817514674794147840)), name: Nickname("bob"), 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:60969 (127.0.0.1:60969)
1772747487.206 sable_ircd     #x1B[2m2026-03-05T21:51:27.205614Z#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), 1772747482), content: TargetedMessageResponse(Services(LogUserIn(AccountId(Snowflake(817514674794147840))))) } }
1772747487.206 sable_ircd     #x1B[2m2026-03-05T21:51:27.205875Z#x1B[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 bob :You have successfully registered
1772747487.206 sable_ircd     #x1B[2m2026-03-05T21:51:27.205938Z#x1B[0m #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
1772747487.206 sable_ircd     #x1B[2m2026-03-05T21:51:27.205973Z#x1B[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(817514674152017922))), UserLogin(UserLogin { account: Some(AccountId(Snowflake(817514674794147840))) }))
1772747487.206 sable_ircd     #x1B[2m2026-03-05T21:51:27.206116Z#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(817514674990878726)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817514674794147840))) }) }; event clock=EventClock(1 => 817514674164600837, 99 => 817514657865936898) my clock=EventClock(1 => 817514674164600837, 99 => 817514657865936898)
1772747487.207 sable_ircd     #x1B[2m2026-03-05T21:51:27.206525Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674990878726)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817514674794147840))) }) }) } #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:57073 (127.0.0.1:57073)
1772747487.209 sable_ircd     #x1B[2m2026-03-05T21:51:27.208442Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674810925059)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: Account(AccountId(Snowflake(817514674794147840))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817514674794147840)), name: Nickname("bob"), 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(817514674810925059)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: Account(AccountId(Snowflake(817514674794147840))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817514674794147840)), name: Nickname("bob"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 817514674164600837, 99 => 817514657865936898) my clock=EventClock(1 => 817514674990878726, 99 => 817514657865936898)
1772747487.209 sable_ircd     #x1B[2m2026-03-05T21:51:27.209067Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674810925059)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: Account(AccountId(Snowflake(817514674794147840))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817514674794147840)), name: Nickname("bob"), 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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674810925059)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: Account(AccountId(Snowflake(817514674794147840))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817514674794147840)), name: Nickname("bob"), 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:57073 (127.0.0.1:57073)
1772747487.213 sable_ircd     #x1B[2m2026-03-05T21:51:27.212867Z#x1B[0m #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(817514674990878726)), timestamp: 1772747487, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 3), old_account: None, new_account: Some(AccountId(Snowflake(817514674794147840))) }), users_to_notify: [] })
1772747487.213 sable_ircd     #x1B[2m2026-03-05T21:51:27.212913Z#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(817514674990878726)), timestamp: 1772747487, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 3), old_account: None, new_account: Some(AccountId(Snowflake(817514674794147840))) }), users_to_notify: [] }
1772747487.213 sable_ircd     #x1B[2m2026-03-05T21:51:27.212986Z#x1B[0m #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(817514674990878726)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] })
1772747487.213 sable_ircd     #x1B[2m2026-03-05T21:51:27.213028Z#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(817514674990878726)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] }
1772747487.213 sable_ircd     #x1B[2m2026-03-05T21:51:27.213097Z#x1B[0m #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(817514674810925059)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] })
1772747487.213 sable_ircd     #x1B[2m2026-03-05T21:51:27.213138Z#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(817514674810925059)), timestamp: 1772747487, change: EventComplete(EventComplete), users_to_notify: [] }
1772747487.251 sable_services #x1B[2m2026-03-05T21:51:27.250766Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674990878726)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817514674794147840))) }) }) } }#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(817514674990878726)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817514674794147840))) }) }; event clock=EventClock(1 => 817514674164600837, 99 => 817514657865936898) my clock=EventClock(1 => 817514674164600837, 99 => 817514674810925059)
1772747487.251 sable_services #x1B[2m2026-03-05T21:51:27.251186Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674990878726)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817514674794147840))) }) }) } }#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514674990878726)), timestamp: 1772747487, clock: EventClock(1 => 817514674164600837, 99 => 817514657865936898), target: User(UserId(Snowflake(817514674152017922))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817514674794147840))) }) }) } #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:60969 (127.0.0.1:60969)
1772747487.316 1 -> S: PING synchronize324.652386165
1772747487.316 S -> 1: REGISTER SUCCESS bob :You have successfully registered
1772747487.316 sable_ircd     #x1B[2m2026-03-05T21:51:27.316132Z#x1B[0m #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
1772747487.316 sable_ircd     #x1B[2m2026-03-05T21:51:27.316185Z#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 synchronize324.652386165"
1772747488.070 sable_ircd     #x1B[2m2026-03-05T21:51:28.069975Z#x1B[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 :synchronize324.652386165
1772747488.071 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize324.652386165
1772747488.071 1 -> S: QUIT
1772747488.071 sable_ircd     #x1B[2m2026-03-05T21:51:28.070963Z#x1B[0m #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
1772747488.071 sable_ircd     #x1B[2m2026-03-05T21:51:28.071008Z#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"
1772747488.171 1 -> S: PING synchronize325.50740546
1772747488.171 sable_ircd     #x1B[2m2026-03-05T21:51:28.171409Z#x1B[0m #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
1772747488.172 sable_ircd     #x1B[2m2026-03-05T21:51:28.171502Z#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 synchronize325.50740546"
1772747489.172 1: waiting…
1772747489.176 sable_ircd     #x1B[2m2026-03-05T21:51:29.175778Z#x1B[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
1772747489.176 sable_ircd     #x1B[2m2026-03-05T21:51:29.175990Z#x1B[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))
1772747489.176 sable_ircd     #x1B[2m2026-03-05T21:51:29.176041Z#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)
1772747489.176 sable_ircd     #x1B[2m2026-03-05T21:51:29.176201Z#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(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 817514674990878726, 99 => 817514674810925059) my clock=EventClock(1 => 817514674990878726, 99 => 817514674810925059)
1772747489.176 S -> 1: ERROR :Client quit
1772747489.177 sable_ircd     #x1B[2m2026-03-05T21:51:29.176630Z#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
1772747489.177 sable_ircd     #x1B[2m2026-03-05T21:51:29.176663Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), 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:57073 (127.0.0.1:57073)
1772747489.177 sable_ircd     #x1B[2m2026-03-05T21:51:29.176722Z#x1B[0m #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
1772747489.179 sable_ircd     #x1B[2m2026-03-05T21:51:29.178601Z#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(817514683262046216)), timestamp: 1772747489, clock: EventClock(1 => 817514683253657607, 99 => 817514674810925059), target: User(UserId(Snowflake(817514674152017922))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 817514683253657607, 99 => 817514674810925059) my clock=EventClock(1 => 817514683253657607, 99 => 817514674810925059)
1772747489.179 sable_ircd     #x1B[2m2026-03-05T21:51:29.179397Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683262046216)), timestamp: 1772747489, clock: EventClock(1 => 817514683253657607, 99 => 817514674810925059), target: User(UserId(Snowflake(817514674152017922))), 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:57073 (127.0.0.1:57073)
1772747489.184 sable_ircd     #x1B[2m2026-03-05T21:51:29.183521Z#x1B[0m #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(817514683253657607)), timestamp: 1772747489, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(817514674152017923)), user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 } }), users_to_notify: [] })
1772747489.184 sable_ircd     #x1B[2m2026-03-05T21:51:29.183579Z#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(817514683253657607)), timestamp: 1772747489, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(817514674152017923)), user: UserId(Snowflake(817514674152017922)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747487 } }), users_to_notify: [] }
1772747489.184 sable_ircd     #x1B[2m2026-03-05T21:51:29.183638Z#x1B[0m #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(817514683253657607)), timestamp: 1772747489, change: EventComplete(EventComplete), users_to_notify: [] })
1772747489.184 sable_ircd     #x1B[2m2026-03-05T21:51:29.183669Z#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(817514683253657607)), timestamp: 1772747489, change: EventComplete(EventComplete), users_to_notify: [] }
1772747489.184 sable_ircd     #x1B[2m2026-03-05T21:51:29.183710Z#x1B[0m #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(817514683262046216)), timestamp: 1772747489, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 3), nickname: Nickname("bob"), message: "Client Quit", memberships: [] }), users_to_notify: [] })
1772747489.184 sable_ircd     #x1B[2m2026-03-05T21:51:29.183741Z#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(817514683262046216)), timestamp: 1772747489, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(817514674152017922)), 3), nickname: Nickname("bob"), message: "Client Quit", memberships: [] }), users_to_notify: [] }
1772747489.184 sable_ircd     #x1B[2m2026-03-05T21:51:29.183814Z#x1B[0m #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(817514683262046216)), timestamp: 1772747489, change: EventComplete(EventComplete), users_to_notify: [] })
1772747489.184 sable_ircd     #x1B[2m2026-03-05T21:51:29.183845Z#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(817514683262046216)), timestamp: 1772747489, change: EventComplete(EventComplete), users_to_notify: [] }
1772747489.184 sable_services #x1B[2m2026-03-05T21:51:29.184270Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683262046216)), timestamp: 1772747489, clock: EventClock(1 => 817514683253657607, 99 => 817514674810925059), target: User(UserId(Snowflake(817514674152017922))), 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(817514683262046216)), timestamp: 1772747489, clock: EventClock(1 => 817514683253657607, 99 => 817514674810925059), target: User(UserId(Snowflake(817514674152017922))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 817514683253657607, 99 => 817514674810925059) my clock=EventClock(1 => 817514674990878726, 99 => 817514674810925059)
1772747489.184 sable_services #x1B[2m2026-03-05T21:51:29.184381Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683262046216)), timestamp: 1772747489, clock: EventClock(1 => 817514683253657607, 99 => 817514674810925059), target: User(UserId(Snowflake(817514674152017922))), 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(817514683253657607))]
1772747489.185 sable_services #x1B[2m2026-03-05T21:51:29.184803Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683262046216)), timestamp: 1772747489, clock: EventClock(1 => 817514683253657607, 99 => 817514674810925059), target: User(UserId(Snowflake(817514674152017922))), 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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683262046216)), timestamp: 1772747489, clock: EventClock(1 => 817514683253657607, 99 => 817514674810925059), target: User(UserId(Snowflake(817514674152017922))), 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:60969 (127.0.0.1:60969)
1772747489.220 sable_services #x1B[2m2026-03-05T21:51:29.219838Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), 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(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 817514674990878726, 99 => 817514674810925059) my clock=EventClock(1 => 817514674990878726, 99 => 817514674810925059)
1772747489.220 sable_services #x1B[2m2026-03-05T21:51:29.219917Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), 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(817514683262046216)), timestamp: 1772747489, clock: EventClock(1 => 817514683253657607, 99 => 817514674810925059), target: User(UserId(Snowflake(817514674152017922))), details: UserQuit(UserQuit { message: "Client Quit" }) }
1772747489.220 sable_services #x1B[2m2026-03-05T21:51:29.220251Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), 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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), 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:60969 (127.0.0.1:60969)
1772747489.226 sable_ircd     #x1B[2m2026-03-05T21:51:29.225536Z#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), 1772747482), content: GetEvent([EventId(Snowflake(817514683253657607))]) } }#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(817514683253657607))]
1772747489.226 sable_ircd     #x1B[2m2026-03-05T21:51:29.225590Z#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), 1772747482), content: GetEvent([EventId(Snowflake(817514683253657607))]) } }#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(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), details: UserDisconnect(UserDisconnect) }]
1772747489.250 sable_history  #x1B[2m2027-03-05T21:59:56.356767Z#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(949788381464961035)), timestamp: 1804283996, clock: EventClock(1 => 949786103294988289, 50 => 949788129806721034), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283996 }) }; event clock=EventClock(1 => 949786103294988289, 50 => 949788129806721034) my clock=EventClock(1 => 949786103294988289, 50 => 949788129806721034)
1772747489.250 sable_history  #x1B[2m2027-03-05T21:59:56.362694Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788381464961035)), timestamp: 1804283996, clock: EventClock(1 => 949786103294988289, 50 => 949788129806721034), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283996 }) }) } #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:58223. Last error: I/O error: Connection refused (os error 111)
1772747489.250 sable_history  #x1B[2m2027-03-05T21:59:56.363346Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788381464961035)), timestamp: 1804283996, clock: EventClock(1 => 949786103294988289, 50 => 949788129806721034), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283996 }) }) } #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)
1772747489.250 sable_history  #x1B[2m2027-03-05T21:59:56.363822Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111)
1772747489.267 sable_services #x1B[2m2026-03-05T21:51:29.266605Z#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), 1772747482), content: BulkEvents([Event { id: EventId(Snowflake(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), 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(817514683253657607)), timestamp: 1772747489, clock: EventClock(1 => 817514674990878726, 99 => 817514674810925059), target: UserConnection(UserConnectionId(Snowflake(817514674152017923))), details: UserDisconnect(UserDisconnect) }]
1772747489.277 1 -> S: PING synchronize326.613259124
1772747489.277 chanop: connects to server.
1772747489.277 chanop -> S: NICK chanop
1772747489.277 chanop -> S: USER username * * :Realname
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.277537Z#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 }
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.277683Z#x1B[0m #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
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.277742Z#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
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.277816Z#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
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.277966Z#x1B[0m #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
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.278017Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK chanop"
1772747489.278 S -> chanop: :My.Little.Server NOTICE * :*** Looking up your hostname
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.278137Z#x1B[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: 326, tv_nsec: 614457126 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("chanop")), realname: OnceLock(<uninit>), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.278203Z#x1B[0m #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
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.278237Z#x1B[0m #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
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.278275Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER username * * :Realname"
1772747489.278 sable_ircd     #x1B[2m2026-03-05T21:51:29.278382Z#x1B[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: 326, tv_nsec: 614457126 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("chanop")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747489.279 sable_ircd     #x1B[2m2026-03-05T21:51:29.278967Z#x1B[0m #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
1772747489.279 sable_ircd     #x1B[2m2026-03-05T21:51:29.279005Z#x1B[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"))
1772747489.279 sable_ircd     #x1B[2m2026-03-05T21:51:29.279050Z#x1B[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
1772747489.279 sable_ircd     #x1B[2m2026-03-05T21:51:29.279089Z#x1B[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: 326, tv_nsec: 614457126 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("chanop")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747489.279 sable_ircd     #x1B[2m2026-03-05T21:51:29.279158Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mRegisterClient(ConnectionId(ListenerId(0), 4))
1772747489.280 sable_ircd     #x1B[2m2026-03-05T21:51:29.279416Z#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(817514683685670921)), timestamp: 1772747489, clock: EventClock(1 => 817514683262046216, 99 => 817514674810925059), target: User(UserId(Snowflake(817514683685670916))), details: NewUser(NewUser { nickname: Nickname("chanop"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817514683685670917)), NewUserConnection { user: UserId(Snowflake(817514683685670916)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747489 })) }) }; event clock=EventClock(1 => 817514683262046216, 99 => 817514674810925059) my clock=EventClock(1 => 817514683262046216, 99 => 817514674810925059)
1772747489.280 S -> chanop: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1772747489.280 sable_ircd     #x1B[2m2026-03-05T21:51:29.279781Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683685670921)), timestamp: 1772747489, clock: EventClock(1 => 817514683262046216, 99 => 817514674810925059), target: User(UserId(Snowflake(817514683685670916))), details: NewUser(NewUser { nickname: Nickname("chanop"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817514683685670917)), NewUserConnection { user: UserId(Snowflake(817514683685670916)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747489 })) }) }) } #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:57073 (127.0.0.1:57073)
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.281870Z#x1B[0m #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(817514683685670921)), timestamp: 1772747489, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514683685670916)), 1) }), users_to_notify: [] })
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.281922Z#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(817514683685670921)), timestamp: 1772747489, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514683685670916)), 1) }), users_to_notify: [] }
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.281981Z#x1B[0m #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(817514683685670921)), timestamp: 1772747489, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514683685670916)), 2), connection: UserConnectionId(Snowflake(817514683685670917)) }), users_to_notify: [] })
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282020Z#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(817514683685670921)), timestamp: 1772747489, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514683685670916)), 2), connection: UserConnectionId(Snowflake(817514683685670917)) }), users_to_notify: [] }
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282092Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 001 chanop :Welcome to the test Internet Relay Chat network, chanop
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282149Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 002 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282175Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 003 chanop :This server was created 2026-03-05 21:51:29.282166389 UTC
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282189Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 004 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282208Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 005 chanop EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282223Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 422 chanop :MOTD File is missing
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282239Z#x1B[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): :chanop!username@localhost MODE chanop +
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282256Z#x1B[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 chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282282Z#x1B[0m #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(817514683685670921)), timestamp: 1772747489, change: EventComplete(EventComplete), users_to_notify: [] })
1772747489.282 sable_ircd     #x1B[2m2026-03-05T21:51:29.282301Z#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(817514683685670921)), timestamp: 1772747489, change: EventComplete(EventComplete), users_to_notify: [] }
1772747489.283 S -> chanop: :My.Little.Server 001 chanop :Welcome to the test Internet Relay Chat network, chanop
1772747489.283 S -> chanop: :My.Little.Server 002 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747489.283 chanop -> S: PING foo
1772747489.283 sable_ircd     #x1B[2m2026-03-05T21:51:29.282891Z#x1B[0m #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
1772747489.283 sable_ircd     #x1B[2m2026-03-05T21:51:29.282931Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING foo"
1772747489.283 sable_ircd     #x1B[2m2026-03-05T21:51:29.282999Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :foo
1772747489.324 sable_services #x1B[2m2026-03-05T21:51:29.323724Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683685670921)), timestamp: 1772747489, clock: EventClock(1 => 817514683262046216, 99 => 817514674810925059), target: User(UserId(Snowflake(817514683685670916))), details: NewUser(NewUser { nickname: Nickname("chanop"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817514683685670917)), NewUserConnection { user: UserId(Snowflake(817514683685670916)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747489 })) }) }) } }#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(817514683685670921)), timestamp: 1772747489, clock: EventClock(1 => 817514683262046216, 99 => 817514674810925059), target: User(UserId(Snowflake(817514683685670916))), details: NewUser(NewUser { nickname: Nickname("chanop"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817514683685670917)), NewUserConnection { user: UserId(Snowflake(817514683685670916)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747489 })) }) }; event clock=EventClock(1 => 817514683262046216, 99 => 817514674810925059) my clock=EventClock(1 => 817514683262046216, 99 => 817514674810925059)
1772747489.324 sable_services #x1B[2m2026-03-05T21:51:29.324095Z#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683685670921)), timestamp: 1772747489, clock: EventClock(1 => 817514683262046216, 99 => 817514674810925059), target: User(UserId(Snowflake(817514683685670916))), details: NewUser(NewUser { nickname: Nickname("chanop"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817514683685670917)), NewUserConnection { user: UserId(Snowflake(817514683685670916)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747489 })) }) }) } }#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), 1772747482), content: NewEvent(Event { id: EventId(Snowflake(817514683685670921)), timestamp: 1772747489, clock: EventClock(1 => 817514683262046216, 99 => 817514674810925059), target: User(UserId(Snowflake(817514683685670916))), details: NewUser(NewUser { nickname: Nickname("chanop"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817514683685670917)), NewUserConnection { user: UserId(Snowflake(817514683685670916)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747489 })) }) }) } #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:60969 (127.0.0.1:60969)
1772747489.483 chanop -> S: PING synchronize326.819504199
1772747489.483 S -> chanop: :My.Little.Server 003 chanop :This server was created 2026-03-05 21:51:29.282166389 UTC
1772747489.483 S -> chanop: :My.Little.Server 004 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747489.483 S -> chanop: :My.Little.Server 005 chanop EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1772747489.483 S -> chanop: :My.Little.Server 422 chanop :MOTD File is missing
1772747489.483 S -> chanop: :chanop!username@localhost MODE chanop +
1772747489.483 S -> chanop: :My.Little.Server NOTICE chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747489.483 S -> chanop: :My.Little.Server PONG My.Little.Server :foo
1772747489.483 sable_ircd     #x1B[2m2026-03-05T21:51:29.483434Z#x1B[0m #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
1772747489.484 sable_ircd     #x1B[2m2026-03-05T21:51:29.483503Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize326.819504199"
1772747489.484 sable_ircd     #x1B[2m2026-03-05T21:51:29.483642Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :synchronize326.819504199
1772747489.484 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize326.819504199
1772747489.686 sable_history  #x1B[2m2027-03-05T21:59:56.591352Z#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(949788382446428171)), timestamp: 1804283996, clock: EventClock(1 => 949786183724961807, 50 => 949788130792382474, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283996 }) }; event clock=EventClock(1 => 949786183724961807, 50 => 949788130792382474, 99 => 949786173562564612) my clock=EventClock(1 => 949786183724961807, 50 => 949788130792382474, 99 => 949786173562564612)
1772747489.686 sable_history  #x1B[2m2027-03-05T21:59:56.598713Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788382446428171)), timestamp: 1804283996, clock: EventClock(1 => 949786183724961807, 50 => 949788130792382474, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283996 }) }) } #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 Could not connect to 127.0.0.1:37225. Last error: I/O error: Connection refused (os error 111)
1772747489.686 sable_history  #x1B[2m2027-03-05T21:59:56.599363Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788382446428171)), timestamp: 1804283996, clock: EventClock(1 => 949786183724961807, 50 => 949788130792382474, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283996 }) }) } #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 #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111)
1772747489.686 sable_history  #x1B[2m2027-03-05T21:59:56.599833Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111)
1772747489.686 sable_history  #x1B[2m2027-03-05T21:59:56.600276Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788382446428171)), timestamp: 1804283996, clock: EventClock(1 => 949786183724961807, 50 => 949788130792382474, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283996 }) }) } #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:44627. Last error: I/O error: Connection refused (os error 111)
1772747489.686 sable_history  #x1B[2m2027-03-05T21:59:56.600571Z#x1B[0m #x1B[31mERROR#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(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949788382446428171)), timestamp: 1804283996, clock: EventClock(1 => 949786183724961807, 50 => 949788130792382474, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283996 }) }) } #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)
1772747489.686 sable_history  #x1B[2m2027-03-05T21:59:56.600921Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111)
1772747490.088 sable_ircd     #x1B[2m2026-03-05T21:51:30.087685Z#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
1772747490.088 sable_ircd     #x1B[2m2026-03-05T21:51:30.087844Z#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:60969, peer: 127.0.0.1:58771, fd: 19 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x55e180168990, 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
1772747490.095 chanop: disconnects from server.