--------------------------------- Captured Out ---------------------------------
---- new test ----
1772747552.824 sable_ircd     uid=1001
1772747552.828 sable_ircd     #x1B[2m2026-03-05T21:52:32.827735Z#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(817514950225301504)), timestamp: 1772747552, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747552, name: ServerName("My.Little.Server"), ts: 1772747552, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1772747552.828 sable_ircd     #x1B[2m2026-03-05T21:52:32.827853Z#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
1772747552.828 sable_ircd     #x1B[2m2026-03-05T21:52:32.828063Z#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(817514950225301504)), timestamp: 1772747552, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747552, name: ServerName("My.Little.Server"), ts: 1772747552, 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
1772747552.828 sable_ircd     #x1B[2m2026-03-05T21:52:32.828252Z#x1B[0m #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(817514950225301504)), timestamp: 1772747552, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1772747552.828 sable_ircd     #x1B[2m2026-03-05T21:52:32.828302Z#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(817514950225301504)), timestamp: 1772747552, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1772747552.828 sable_ircd     #x1B[2m2026-03-05T21:52:32.828394Z#x1B[0m #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(817514950225301504)), timestamp: 1772747552, change: EventComplete(EventComplete), users_to_notify: [] })
1772747552.828 sable_ircd     #x1B[2m2026-03-05T21:52:32.828434Z#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(817514950225301504)), timestamp: 1772747552, change: EventComplete(EventComplete), users_to_notify: [] }
1772747552.829 sable_ircd     #x1B[2m2026-03-05T21:52:32.828539Z#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(817514950229495809)), timestamp: 1772747552, clock: EventClock(1 => 817514950225301504), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1772747552 }) }; event clock=EventClock(1 => 817514950225301504) my clock=EventClock(1 => 817514950225301504)
1772747552.829 sable_ircd     #x1B[2m2026-03-05T21:52:32.828608Z#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
1772747552.829 sable_ircd     #x1B[2m2026-03-05T21:52:32.828833Z#x1B[0m #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(817514950229495809)), timestamp: 1772747552, change: EventComplete(EventComplete), users_to_notify: [] })
1772747552.829 sable_ircd     #x1B[2m2026-03-05T21:52:32.828875Z#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(817514950229495809)), timestamp: 1772747552, change: EventComplete(EventComplete), users_to_notify: [] }
1772747552.830 sable_ircd     #x1B[2m2026-03-05T21:52:32.829456Z#x1B[0m #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
1772747552.920 sable_ircd     #x1B[2m2026-03-05T21:52:32.920223Z#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 }
1772747552.920 sable_ircd     #x1B[2m2026-03-05T21:52:32.920409Z#x1B[0m #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
1772747552.921 sable_ircd     #x1B[2m2026-03-05T21:52:32.920481Z#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
1772747552.921 sable_ircd     #x1B[2m2026-03-05T21:52:32.920571Z#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
1772747552.921 sable_ircd     #x1B[2m2026-03-05T21:52:32.920731Z#x1B[0m #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
1772747552.921 sable_ircd     #x1B[2m2026-03-05T21:52:32.920792Z#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"
1772747552.921 sable_ircd     #x1B[2m2026-03-05T21:52:32.920939Z#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
1772747552.921 sable_ircd     #x1B[2m2026-03-05T21:52:32.921043Z#x1B[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))
1772747552.921 sable_ircd     #x1B[2m2026-03-05T21:52:32.921071Z#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)
1772747552.922 sable_ircd     #x1B[2m2026-03-05T21:52:32.921541Z#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
1772747552.922 sable_ircd     #x1B[2m2026-03-05T21:52:32.921643Z#x1B[0m #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
1772747552.922 sable_ircd     #x1B[2m2026-03-05T21:52:32.921859Z#x1B[0m #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
1772747552.941 alice: connects to server.
1772747552.941 alice -> S: CAP LS 302
1772747552.942 sable_ircd     #x1B[2m2026-03-05T21:52:32.941704Z#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 }
1772747552.942 sable_ircd     #x1B[2m2026-03-05T21:52:32.941826Z#x1B[0m #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
1772747552.942 sable_ircd     #x1B[2m2026-03-05T21:52:32.941863Z#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
1772747552.942 sable_ircd     #x1B[2m2026-03-05T21:52:32.941905Z#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
1772747552.942 sable_ircd     #x1B[2m2026-03-05T21:52:32.942021Z#x1B[0m #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
1772747552.942 sable_ircd     #x1B[2m2026-03-05T21:52:32.942084Z#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"
1772747552.942 S -> alice: :My.Little.Server NOTICE * :*** Looking up your hostname
1772747552.942 sable_ircd     #x1B[2m2026-03-05T21:52:32.942202Z#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
1772747552.943 S -> alice: :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
1772747552.943 alice -> S: CAP REQ :message-tags echo-message
1772747552.943 sable_ircd     #x1B[2m2026-03-05T21:52:32.942736Z#x1B[0m #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
1772747552.943 sable_ircd     #x1B[2m2026-03-05T21:52:32.942796Z#x1B[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"))
1772747552.943 sable_ircd     #x1B[2m2026-03-05T21:52:32.942848Z#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
1772747552.943 sable_ircd     #x1B[2m2026-03-05T21:52:32.942906Z#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: 390, tv_nsec: 278559398 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(<uninit>), realname: OnceLock(<uninit>), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747552.943 S -> alice: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1772747552.943 sable_ircd     #x1B[2m2026-03-05T21:52:32.943148Z#x1B[0m #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
1772747552.943 sable_ircd     #x1B[2m2026-03-05T21:52:32.943207Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP REQ :message-tags echo-message"
1772747552.943 sable_ircd     #x1B[2m2026-03-05T21:52:32.943373Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server CAP * ACK :message-tags echo-message
1772747552.943 sable_ircd     #x1B[2m2026-03-05T21:52:32.943409Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mUpdateConnectionCaps(ConnectionId(ListenerId(0), 2), ClientCapabilitySet(5))
1772747552.983 S -> alice: :My.Little.Server CAP * ACK :message-tags echo-message
1772747552.984 alice -> S: NICK alice
1772747552.984 alice -> S: USER username * * :Realname
1772747552.984 alice -> S: CAP END
1772747552.984 sable_ircd     #x1B[2m2026-03-05T21:52:32.984006Z#x1B[0m #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
1772747552.984 sable_ircd     #x1B[2m2026-03-05T21:52:32.984061Z#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 alice"
1772747552.984 sable_ircd     #x1B[2m2026-03-05T21:52:32.984195Z#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: 390, tv_nsec: 278559398 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("alice")), realname: OnceLock(<uninit>), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747552.984 sable_ircd     #x1B[2m2026-03-05T21:52:32.984261Z#x1B[0m #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
1772747552.984 sable_ircd     #x1B[2m2026-03-05T21:52:32.984305Z#x1B[0m #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
1772747552.984 sable_ircd     #x1B[2m2026-03-05T21:52:32.984359Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER username * * :Realname"
1772747552.984 sable_ircd     #x1B[2m2026-03-05T21:52:32.984437Z#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: 390, tv_nsec: 278559398 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("alice")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747552.985 sable_ircd     #x1B[2m2026-03-05T21:52:32.984492Z#x1B[0m #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
1772747552.985 sable_ircd     #x1B[2m2026-03-05T21:52:32.984521Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP END"
1772747553.235 sable_ircd     #x1B[2m2026-03-05T21:52:33.235122Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::complete_progress #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 390, tv_nsec: 278559398 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("alice")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mflag#x1B[0m#x1B[2m=#x1B[0mCapNegotiation #x1B[3mresult#x1B[0m#x1B[2m=#x1B[0mtrue
1772747553.235 sable_ircd     #x1B[2m2026-03-05T21:52:33.235238Z#x1B[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))
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.235497Z#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(817514951936577538)), timestamp: 1772747553, clock: EventClock(1 => 817514950229495809), target: User(UserId(Snowflake(817514951936577536))), details: NewUser(NewUser { nickname: Nickname("alice"), 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(817514951936577537)), NewUserConnection { user: UserId(Snowflake(817514951936577536)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747553 })) }) }; event clock=EventClock(1 => 817514950229495809) my clock=EventClock(1 => 817514950229495809)
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.235574Z#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
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.235826Z#x1B[0m #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(817514951936577538)), timestamp: 1772747553, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514951936577536)), 1) }), users_to_notify: [] })
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.235860Z#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(817514951936577538)), timestamp: 1772747553, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514951936577536)), 1) }), users_to_notify: [] }
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.235908Z#x1B[0m #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(817514951936577538)), timestamp: 1772747553, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514951936577536)), 2), connection: UserConnectionId(Snowflake(817514951936577537)) }), users_to_notify: [] })
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.235932Z#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(817514951936577538)), timestamp: 1772747553, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514951936577536)), 2), connection: UserConnectionId(Snowflake(817514951936577537)) }), users_to_notify: [] }
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.235975Z#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 alice :Welcome to the test Internet Relay Chat network, alice
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.236011Z#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 alice :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.236040Z#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 alice :This server was created 2026-03-05 21:52:33.236025977 UTC
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.236072Z#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 alice My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.236128Z#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 alice 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
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.236188Z#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 alice :MOTD File is missing
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.236236Z#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): :alice!username@localhost MODE alice +
1772747553.236 sable_ircd     #x1B[2m2026-03-05T21:52:33.236292Z#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 alice :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747553.236 S -> alice: :My.Little.Server 001 alice :Welcome to the test Internet Relay Chat network, alice
1772747553.237 alice -> S: PING foo
1772747553.237 sable_ircd     #x1B[2m2026-03-05T21:52:33.236375Z#x1B[0m #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(817514951936577538)), timestamp: 1772747553, change: EventComplete(EventComplete), users_to_notify: [] })
1772747553.237 sable_ircd     #x1B[2m2026-03-05T21:52:33.236412Z#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(817514951936577538)), timestamp: 1772747553, change: EventComplete(EventComplete), users_to_notify: [] }
1772747553.237 sable_ircd     #x1B[2m2026-03-05T21:52:33.236710Z#x1B[0m #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
1772747553.237 sable_ircd     #x1B[2m2026-03-05T21:52:33.236752Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING foo"
1772747553.337 alice -> S: PING synchronize390.673307257
1772747553.337 S -> alice: :My.Little.Server 002 alice :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747553.337 S -> alice: :My.Little.Server 003 alice :This server was created 2026-03-05 21:52:33.236025977 UTC
1772747553.337 S -> alice: :My.Little.Server 004 alice My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747553.337 S -> alice: :My.Little.Server 005 alice 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
1772747553.337 S -> alice: :My.Little.Server 422 alice :MOTD File is missing
1772747553.337 S -> alice: :alice!username@localhost MODE alice +
1772747553.337 S -> alice: :My.Little.Server NOTICE alice :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747553.337 sable_ircd     #x1B[2m2026-03-05T21:52:33.337182Z#x1B[0m #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
1772747553.337 sable_ircd     #x1B[2m2026-03-05T21:52:33.337251Z#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 synchronize390.673307257"
1772747553.485 sable_history  #x1B[2m2027-03-05T22:12:12.460047Z#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(949791468904718361)), timestamp: 1804284732, clock: EventClock(1 => 949786674810851350, 50 => 949791217246478360, 99 => 949786678212833284), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804284732 }) }; event clock=EventClock(1 => 949786674810851350, 50 => 949791217246478360, 99 => 949786678212833284) my clock=EventClock(1 => 949786674810851350, 50 => 949791217246478360, 99 => 949786678212833284)
1772747553.485 sable_history  #x1B[2m2027-03-05T22:12:12.461704Z#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
1772747553.852 sable_history  #x1B[2m2027-03-05T22:01:56.661022Z#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(949788886056509452)), timestamp: 1804284116, clock: EventClock(1 => 949787112654245921, 50 => 949788634398269451, 99 => 949787117096415237), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804284116 }) }; event clock=EventClock(1 => 949787112654245921, 50 => 949788634398269451, 99 => 949787117096415237) my clock=EventClock(1 => 949787112654245921, 50 => 949788634398269451, 99 => 949787117096415237)
1772747553.852 sable_history  #x1B[2m2027-03-05T22:01:56.668535Z#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), 1804283513), content: NewEvent(Event { id: EventId(Snowflake(949788886056509452)), timestamp: 1804284116, clock: EventClock(1 => 949787112654245921, 50 => 949788634398269451, 99 => 949787117096415237), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804284116 }) }) } #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:36117. Last error: I/O error: Connection refused (os error 111)
1772747553.852 sable_history  #x1B[2m2027-03-05T22:01:56.669200Z#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), 1804283513), content: NewEvent(Event { id: EventId(Snowflake(949788886056509452)), timestamp: 1804284116, clock: EventClock(1 => 949787112654245921, 50 => 949788634398269451, 99 => 949787117096415237), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804284116 }) }) } #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)
1772747553.852 sable_history  #x1B[2m2027-03-05T22:01:56.669682Z#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)
1772747553.852 sable_history  #x1B[2m2027-03-05T22:01:56.670176Z#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), 1804283513), content: NewEvent(Event { id: EventId(Snowflake(949788886056509452)), timestamp: 1804284116, clock: EventClock(1 => 949787112654245921, 50 => 949788634398269451, 99 => 949787117096415237), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804284116 }) }) } #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:38485. Last error: I/O error: Connection refused (os error 111)
1772747553.852 sable_history  #x1B[2m2027-03-05T22:01:56.670486Z#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), 1804283513), content: NewEvent(Event { id: EventId(Snowflake(949788886056509452)), timestamp: 1804284116, clock: EventClock(1 => 949787112654245921, 50 => 949788634398269451, 99 => 949787117096415237), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804284116 }) }) } #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)
1772747553.852 sable_history  #x1B[2m2027-03-05T22:01:56.671335Z#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)
1772747554.091 sable_ircd     #x1B[2m2026-03-05T21:52:34.091124Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :foo
1772747554.092 S -> alice: :My.Little.Server PONG My.Little.Server :foo
1772747554.110 sable_history  #x1B[2m2027-03-05T22:15:01.008618Z#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(949792175846268956)), timestamp: 1804284901, clock: EventClock(1 => 949786627163557910, 50 => 949791924188028955, 99 => 949786630502625284), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804284901 }) }; event clock=EventClock(1 => 949786627163557910, 50 => 949791924188028955, 99 => 949786630502625284) my clock=EventClock(1 => 949786627163557910, 50 => 949791924188028955, 99 => 949786630502625284)
1772747554.110 sable_history  #x1B[2m2027-03-05T22:15:01.010240Z#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
1772747554.211 sable_history  #x1B[2m2027-03-05T21:59:11.037453Z#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(949788191379103753)), timestamp: 1804283951, clock: EventClock(1 => 949786416022294531, 50 => 949787939720863752), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283951 }) }; event clock=EventClock(1 => 949786416022294531, 50 => 949787939720863752) my clock=EventClock(1 => 949786416022294531, 50 => 949787939720863752)
1772747554.212 sable_history  #x1B[2m2027-03-05T21:59:11.042716Z#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), 1804283525), content: NewEvent(Event { id: EventId(Snowflake(949788191379103753)), timestamp: 1804283951, clock: EventClock(1 => 949786416022294531, 50 => 949787939720863752), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283951 }) }) } #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:42621. Last error: I/O error: Connection refused (os error 111)
1772747554.212 sable_history  #x1B[2m2027-03-05T21:59:11.043466Z#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), 1804283525), content: NewEvent(Event { id: EventId(Snowflake(949788191379103753)), timestamp: 1804283951, clock: EventClock(1 => 949786416022294531, 50 => 949787939720863752), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283951 }) }) } #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)
1772747554.212 sable_history  #x1B[2m2027-03-05T21:59:11.044433Z#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)
1772747554.649 sable_history  #x1B[2m2027-03-05T21:59:09.562213Z#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(949788185192505353)), timestamp: 1804283949, clock: EventClock(1 => 949786411253370881, 50 => 949787933534265352), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283949 }) }; event clock=EventClock(1 => 949786411253370881, 50 => 949787933534265352) my clock=EventClock(1 => 949786411253370881, 50 => 949787933534265352)
1772747554.649 sable_history  #x1B[2m2027-03-05T21:59:09.567976Z#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), 1804283526), content: NewEvent(Event { id: EventId(Snowflake(949788185192505353)), timestamp: 1804283949, clock: EventClock(1 => 949786411253370881, 50 => 949787933534265352), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283949 }) }) } #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:38369. Last error: I/O error: Connection refused (os error 111)
1772747554.649 sable_history  #x1B[2m2027-03-05T21:59:09.568882Z#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), 1804283526), content: NewEvent(Event { id: EventId(Snowflake(949788185192505353)), timestamp: 1804283949, clock: EventClock(1 => 949786411253370881, 50 => 949787933534265352), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283949 }) }) } #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)
1772747554.649 sable_history  #x1B[2m2027-03-05T21:59:09.569349Z#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)
1772747554.728 sable_history  #x1B[2m2027-03-05T22:17:58.431445Z#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(949792920012267551)), timestamp: 1804285078, clock: EventClock(1 => 949786576752218129, 50 => 949792668354027550, 99 => 949786583388008453), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804285078 }) }; event clock=EventClock(1 => 949786576752218129, 50 => 949792668354027550, 99 => 949786583388008453) my clock=EventClock(1 => 949786576752218129, 50 => 949792668354027550, 99 => 949786583388008453)
1772747554.728 sable_history  #x1B[2m2027-03-05T22:17:58.432847Z#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
1772747554.893 sable_history  #x1B[2m2027-03-05T22:04:45.799832Z#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(949789595476893713)), timestamp: 1804284285, clock: EventClock(1 => 949786815001268246, 50 => 949789343919317008, 99 => 949786818277421060), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804284285 }) }; event clock=EventClock(1 => 949786815001268246, 50 => 949789343919317008, 99 => 949786818277421060) my clock=EventClock(1 => 949786815001268246, 50 => 949789343919317008, 99 => 949786818277421060)
1772747554.893 sable_history  #x1B[2m2027-03-05T22:04:45.801380Z#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
1772747555.092 alice: waiting…
1772747555.097 sable_history  #x1B[2m2027-03-05T21:59:09.968868Z#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(949788186899587081)), timestamp: 1804283949, clock: EventClock(1 => 949786413140807681, 50 => 949787935241347080), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283949 }) }; event clock=EventClock(1 => 949786413140807681, 50 => 949787935241347080) my clock=EventClock(1 => 949786413140807681, 50 => 949787935241347080)
1772747555.097 sable_ircd     #x1B[2m2026-03-05T21:52:35.096760Z#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 :synchronize390.673307257
1772747555.097 sable_history  #x1B[2m2027-03-05T21:59:09.974899Z#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), 1804283526), content: NewEvent(Event { id: EventId(Snowflake(949788186899587081)), timestamp: 1804283949, clock: EventClock(1 => 949786413140807681, 50 => 949787935241347080), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283949 }) }) } #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:37457. Last error: I/O error: Connection refused (os error 111)
1772747555.097 sable_history  #x1B[2m2027-03-05T21:59:09.975911Z#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), 1804283526), content: NewEvent(Event { id: EventId(Snowflake(949788186899587081)), timestamp: 1804283949, clock: EventClock(1 => 949786413140807681, 50 => 949787935241347080), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283949 }) }) } #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)
1772747555.097 sable_history  #x1B[2m2027-03-05T21:59:09.976801Z#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)
1772747555.097 S -> alice: :My.Little.Server PONG My.Little.Server :synchronize390.673307257
1772747555.540 sable_history  #x1B[2m2027-03-05T22:07:34.400871Z#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(949790302640742420)), timestamp: 1804284454, clock: EventClock(1 => 949786767345586198, 50 => 949790050982502419, 99 => 949786770697236484), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804284454 }) }; event clock=EventClock(1 => 949786767345586198, 50 => 949790050982502419, 99 => 949786770697236484) my clock=EventClock(1 => 949786767345586198, 50 => 949790050982502419, 99 => 949786770697236484)
1772747555.540 sable_history  #x1B[2m2027-03-05T22:07:34.402868Z#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
1772747555.546 sable_history  #x1B[2m2027-03-05T21:59:10.386586Z#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(949788188652806153)), timestamp: 1804283950, clock: EventClock(1 => 949786421634273283, 50 => 949787936994566152), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283950 }) }; event clock=EventClock(1 => 949786421634273283, 50 => 949787936994566152) my clock=EventClock(1 => 949786421634273283, 50 => 949787936994566152)
1772747555.546 sable_history  #x1B[2m2027-03-05T21:59:10.392452Z#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), 1804283527), content: NewEvent(Event { id: EventId(Snowflake(949788188652806153)), timestamp: 1804283950, clock: EventClock(1 => 949786421634273283, 50 => 949787936994566152), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283950 }) }) } #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:48463. Last error: I/O error: Connection refused (os error 111)
1772747555.546 sable_history  #x1B[2m2027-03-05T21:59:10.393163Z#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), 1804283527), content: NewEvent(Event { id: EventId(Snowflake(949788188652806153)), timestamp: 1804283950, clock: EventClock(1 => 949786421634273283, 50 => 949787936994566152), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283950 }) }) } #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)
1772747555.546 sable_history  #x1B[2m2027-03-05T21:59:10.393699Z#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)
1772747555.801 alice: disconnects from server.