--------------------------------- Captured Out --------------------------------- ---- new test ---- 1774387773.470 sable_ircd uid=1001 1774387773.471 sable_services uid=1001 1774387773.472 sable_services #x1B[2m2026-03-24T21:29:33.471874Z#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:52089", fingerprint: "4d2ce1ebedbf3f849e17745fc85af296bc4ab51a" } 1774387773.472 sable_services #x1B[2m2026-03-24T21:29:33.472146Z#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), 1774387773), 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:52089. Last error: I/O error: Connection refused (os error 111) 1774387773.472 sable_services #x1B[2m2026-03-24T21:29:33.472195Z#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), 1774387773), 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) 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.474119Z#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(824394534245896192)), timestamp: 1774387773, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Server"), ts: 1774387773, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.474247Z#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 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.474465Z#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(824394534245896192)), timestamp: 1774387773, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Server"), ts: 1774387773, 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 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.474576Z#x1B[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(824394534245896192)), timestamp: 1774387773, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.474621Z#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(824394534245896192)), timestamp: 1774387773, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.474677Z#x1B[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(824394534245896192)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.474729Z#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(824394534245896192)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] } 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.474830Z#x1B[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 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.474992Z#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(824394534245896193)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896192), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1774387773 }) }; event clock=EventClock(1 => 824394534245896192) my clock=EventClock(1 => 824394534245896192) 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.475077Z#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 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.475335Z#x1B[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(824394534245896193)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387773.475 sable_ircd #x1B[2m2026-03-24T21:29:33.475362Z#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(824394534245896193)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] } 1774387773.564 sable_ircd #x1B[2m2026-03-24T21:29:33.564075Z#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 } 1774387773.564 sable_ircd #x1B[2m2026-03-24T21:29:33.564229Z#x1B[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 1774387773.564 sable_ircd #x1B[2m2026-03-24T21:29:33.564297Z#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 1774387773.564 sable_ircd #x1B[2m2026-03-24T21:29:33.564356Z#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 1774387773.565 sable_ircd #x1B[2m2026-03-24T21:29:33.564493Z#x1B[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 1774387773.565 sable_ircd #x1B[2m2026-03-24T21:29:33.564565Z#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" 1774387773.565 sable_ircd #x1B[2m2026-03-24T21:29:33.564713Z#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 1774387773.565 sable_ircd #x1B[2m2026-03-24T21:29:33.564818Z#x1B[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)) 1774387773.565 sable_ircd #x1B[2m2026-03-24T21:29:33.564855Z#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) 1774387773.565 sable_ircd #x1B[2m2026-03-24T21:29:33.565355Z#x1B[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 1774387773.566 sable_ircd #x1B[2m2026-03-24T21:29:33.565473Z#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 1774387773.566 sable_ircd #x1B[2m2026-03-24T21:29:33.565535Z#x1B[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 1774387773.567 sable_services #x1B[2m2026-03-24T21:29:33.566622Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.Server"), address: "127.0.0.1:57951", fingerprint: "35f80ff202d2551ef483b71b2a34147488ac9f65" } 1774387773.567 sable_services #x1B[2m2026-03-24T21:29:33.566823Z#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), 1774387773), 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:57951 (127.0.0.1:57951) 1774387773.571 sable_ircd #x1B[2m2026-03-24T21:29:33.571210Z#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 1774387773.585 chkSvs: connects to server. 1774387773.585 chkSvs -> S: NICK chkSvs 1774387773.585 chkSvs -> S: USER chk chk chk chk 1774387773.585 sable_ircd #x1B[2m2026-03-24T21:29:33.585441Z#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 } 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.585524Z#x1B[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 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.585569Z#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 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.585609Z#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 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.585731Z#x1B[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 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.585791Z#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" 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.585912Z#x1B[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 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.585973Z#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" 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.586075Z#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: 531, tv_nsec: 180910921 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(), realname: OnceLock(Realname("chk")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.586171Z#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: 531, tv_nsec: 180910921 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1774387773.586 sable_ircd #x1B[2m2026-03-24T21:29:33.586250Z#x1B[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 1774387773.587 sable_ircd #x1B[2m2026-03-24T21:29:33.586723Z#x1B[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 1774387773.587 sable_ircd #x1B[2m2026-03-24T21:29:33.586764Z#x1B[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")) 1774387773.587 sable_ircd #x1B[2m2026-03-24T21:29:33.586799Z#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 1774387773.587 sable_ircd #x1B[2m2026-03-24T21:29:33.586822Z#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: 531, tv_nsec: 180910921 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1774387773.587 sable_ircd #x1B[2m2026-03-24T21:29:33.586863Z#x1B[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)) 1774387773.587 sable_ircd #x1B[2m2026-03-24T21:29:33.587082Z#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(824394534719852546)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: User(UserId(Snowflake(824394534715658240))), 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(824394534715658241)), NewUserConnection { user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 })) }) }; event clock=EventClock(1 => 824394534245896193) my clock=EventClock(1 => 824394534245896193) 1774387773.587 sable_ircd #x1B[2m2026-03-24T21:29:33.587187Z#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 1774387773.587 sable_ircd #x1B[2m2026-03-24T21:29:33.587410Z#x1B[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(824394534719852546)), timestamp: 1774387773, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(824394534715658240)), 1) }), users_to_notify: [] }) 1774387773.587 sable_ircd #x1B[2m2026-03-24T21:29:33.587456Z#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(824394534719852546)), timestamp: 1774387773, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(824394534715658240)), 1) }), users_to_notify: [] } 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587533Z#x1B[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(824394534719852546)), timestamp: 1774387773, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(824394534715658240)), 2), connection: UserConnectionId(Snowflake(824394534715658241)) }), users_to_notify: [] }) 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587569Z#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(824394534719852546)), timestamp: 1774387773, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(824394534715658240)), 2), connection: UserConnectionId(Snowflake(824394534715658241)) }), users_to_notify: [] } 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587629Z#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 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587671Z#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 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587747Z#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-24 21:29:33.587730567 UTC 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587790Z#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 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587852Z#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 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587889Z#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 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587934Z#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 + 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.587972Z#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. 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.588024Z#x1B[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(824394534719852546)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387773.588 sable_ircd #x1B[2m2026-03-24T21:29:33.588057Z#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(824394534719852546)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] } 1774387773.612 sable_services #x1B[2m2026-03-24T21:29:33.612288Z#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), 1774387773), content: NetworkState(Network { nick_bindings: {}, historic_nick_users: HistoricNickStore { data: {} }, users: {}, historic_users: HistoricUserStore { users: {} }, user_connections: {}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1774387773, name: ServerName("My.Little.Server"), last_ping: 1774387773, 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: {"user_param_1": (3, String(_)), "user_param_2": (1, String(_)), "tls": (0, Boolean(_)), "realname": (2, String(_)), "nick": (0, String(_)), "ip": (0, Ip(_)), "host": (4, String(_)), "user": (5, String(_))} }, new_connection_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [], uint64: [], regex: [] }, fields: {"ip": (0, Ip(_)), "tls": (0, Boolean(_))} }, 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: {"ip": (0, Ip(_)), "mechanism": (0, String(_)), "tls": (0, Boolean(_))} } }, audit_log: {}, accounts: {}, nick_registrations: {}, channel_registrations: {}, channel_accesses: {}, channel_roles: {}, current_services: None, current_history_server_id: None, config: NetworkConfig { opers: [OperConfig { name: "operuser", hash: "$6$z5yA.OfGliDoi/R2$BgSsguS6bxAsPSCygDisgDw5JZuo5.88eU3Hyc7/4OaNpeKIxWGjOggeHzOl0xLiZg1vfwxXjOTFN14wG5vNI." }], debug_mode: true, default_roles: {BuiltinAll: ChannelAccessSet(1114112), BuiltinOp: ChannelAccessSet(222192934775), BuiltinVoice: ChannelAccessSet(4296081441)}, 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 => 824394534245896193), cache_default_channel_roles: OnceLock(), alias_users: OnceLock() }) } 1774387773.612 sable_services #x1B[2m2026-03-24T21:29:33.612444Z#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 1774387773.613 sable_services #x1B[2m2026-03-24T21:29:33.612568Z#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 1774387773.613 sable_services #x1B[2m2026-03-24T21:29:33.613048Z#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(824394534829305856)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Services"), ts: 1774387773, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 824394534245896193) my clock=EventClock(1 => 824394534245896193) 1774387773.613 sable_services #x1B[2m2026-03-24T21:29:33.613371Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534829305856)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Services"), ts: 1774387773, 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:57951 (127.0.0.1:57951) 1774387773.615 sable_services #x1B[2m2026-03-24T21:29:33.615082Z#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(824394534837694465)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534829305856), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774387773 }) }; event clock=EventClock(1 => 824394534245896193, 99 => 824394534829305856) my clock=EventClock(1 => 824394534245896193, 99 => 824394534829305856) 1774387773.616 sable_services #x1B[2m2026-03-24T21:29:33.615754Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534837694465)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534829305856), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774387773 }) }) } #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:57951 (127.0.0.1:57951) 1774387773.619 sable_services #x1B[2m2026-03-24T21:29:33.619397Z#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(824394534829305856)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Services"), ts: 1774387773, 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 1774387773.620 sable_services #x1B[2m2026-03-24T21:29:33.619710Z#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(824394534854471682)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534837694465), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 824394534245896193, 99 => 824394534837694465) my clock=EventClock(1 => 824394534245896193, 99 => 824394534837694465) 1774387773.620 sable_services #x1B[2m2026-03-24T21:29:33.619940Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534854471682)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534837694465), 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:57951 (127.0.0.1:57951) 1774387773.620 sable_ircd #x1B[2m2026-03-24T21:29:33.620152Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534837694465)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534829305856), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774387773 }) }) } }#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(824394534837694465)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534829305856), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774387773 }) }; event clock=EventClock(1 => 824394534245896193, 99 => 824394534829305856) my clock=EventClock(1 => 824394534719852546) 1774387773.620 sable_ircd #x1B[2m2026-03-24T21:29:33.620218Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534837694465)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534829305856), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774387773 }) }) } }#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(824394534829305856))] 1774387773.620 sable_ircd #x1B[2m2026-03-24T21:29:33.620286Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534837694465)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534829305856), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774387773 }) }) } }#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 1774387773.656 sable_ircd #x1B[2m2026-03-24T21:29:33.655991Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534829305856)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Services"), ts: 1774387773, 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(824394534829305856)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Services"), ts: 1774387773, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 824394534245896193) my clock=EventClock(1 => 824394534719852546) 1774387773.656 sable_ircd #x1B[2m2026-03-24T21:29:33.656070Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534829305856)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Services"), ts: 1774387773, 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(824394534837694465)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534829305856), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1774387773 }) } 1774387773.656 sable_ircd #x1B[2m2026-03-24T21:29:33.656155Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534829305856)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Services"), ts: 1774387773, 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 1774387773.656 sable_ircd #x1B[2m2026-03-24T21:29:33.656413Z#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(824394534829305856)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1774387773, name: ServerName("My.Little.Services"), ts: 1774387773, 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 1774387773.657 sable_ircd #x1B[2m2026-03-24T21:29:33.656577Z#x1B[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(824394534829305856)), timestamp: 1774387773, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }) 1774387773.657 sable_ircd #x1B[2m2026-03-24T21:29:33.656615Z#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(824394534829305856)), timestamp: 1774387773, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] } 1774387773.657 sable_ircd #x1B[2m2026-03-24T21:29:33.656668Z#x1B[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(824394534829305856)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387773.657 sable_ircd #x1B[2m2026-03-24T21:29:33.656722Z#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(824394534829305856)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] } 1774387773.657 sable_ircd #x1B[2m2026-03-24T21:29:33.656759Z#x1B[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(824394534837694465)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387773.657 sable_ircd #x1B[2m2026-03-24T21:29:33.656779Z#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(824394534837694465)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] } 1774387773.661 sable_services #x1B[2m2026-03-24T21:29:33.660894Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394534829305856))]) } }#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(824394534829305856))] 1774387773.661 sable_services #x1B[2m2026-03-24T21:29:33.660930Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394534829305856))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [] 1774387773.663 sable_ircd #x1B[2m2026-03-24T21:29:33.662911Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534854471682)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534837694465), 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(824394534854471682)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534837694465), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 824394534245896193, 99 => 824394534837694465) my clock=EventClock(1 => 824394534719852546, 99 => 824394534837694465) 1774387773.663 sable_ircd #x1B[2m2026-03-24T21:29:33.663195Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534854471682)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534837694465), 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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394534854471682)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193, 99 => 824394534837694465), 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:52131 (127.0.0.1:52131) 1774387773.667 sable_ircd #x1B[2m2026-03-24T21:29:33.666721Z#x1B[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(824394534854471682)), timestamp: 1774387773, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }) 1774387773.667 sable_ircd #x1B[2m2026-03-24T21:29:33.666764Z#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(824394534854471682)), timestamp: 1774387773, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] } 1774387773.667 sable_ircd #x1B[2m2026-03-24T21:29:33.666866Z#x1B[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(824394534854471682)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387773.667 sable_ircd #x1B[2m2026-03-24T21:29:33.666913Z#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(824394534854471682)), timestamp: 1774387773, change: EventComplete(EventComplete), users_to_notify: [] } 1774387773.685 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname 1774387773.685 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1774387773.685 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1774387773.685 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1774387773.685 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2026-03-24 21:29:33.587730567 UTC 1774387773.685 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1774387773.685 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 1774387773.685 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing 1774387773.685 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs + 1774387773.685 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1774387773.685 chkSvs -> S: CAP LS 302 1774387773.686 sable_ircd #x1B[2m2026-03-24T21:29:33.685866Z#x1B[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 1774387773.686 sable_ircd #x1B[2m2026-03-24T21:29:33.685932Z#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" 1774387773.686 sable_ircd #x1B[2m2026-03-24T21:29:33.686075Z#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 1774387773.702 sable_ircd #x1B[2m2026-03-24T21:29:33.701952Z#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), 1774387773), 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: [] 1774387773.725 sable_history #x1B[2m2027-03-24T22:11:36.649291Z#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(956676688148897841)), timestamp: 1805926296, clock: EventClock(1 => 956665429391052815, 50 => 956676436499046448, 99 => 956665419446759428), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1805926296 }) }; event clock=EventClock(1 => 956665429391052815, 50 => 956676436499046448, 99 => 956665419446759428) my clock=EventClock(1 => 956665429391052815, 50 => 956676436499046448, 99 => 956665419446759428) 1774387773.726 sable_history #x1B[2m2027-03-24T22:11:36.650975Z#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 1774387773.736 chkSvs -> S: PING synchronize531.330899588 1774387773.736 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 1774387773.736 sable_ircd #x1B[2m2026-03-24T21:29:33.735983Z#x1B[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 1774387773.736 sable_ircd #x1B[2m2026-03-24T21:29:33.736047Z#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 synchronize531.330899588" 1774387773.736 sable_ircd #x1B[2m2026-03-24T21:29:33.736179Z#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 :synchronize531.330899588 1774387773.736 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize531.330899588 1774387773.737 chkSvs -> S: QUIT 1774387773.737 chkSvs -> S: PING synchronize531.3318861 1774387773.737 sable_ircd #x1B[2m2026-03-24T21:29:33.736799Z#x1B[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 1774387773.737 sable_ircd #x1B[2m2026-03-24T21:29:33.736837Z#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" 1774387773.737 sable_ircd #x1B[2m2026-03-24T21:29:33.736901Z#x1B[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 1774387773.737 sable_ircd #x1B[2m2026-03-24T21:29:33.736934Z#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 synchronize531.3318861" 1774387774.239 sable_ircd #x1B[2m2026-03-24T21:29:34.238945Z#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 1774387774.239 sable_ircd #x1B[2m2026-03-24T21:29:34.239070Z#x1B[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)) 1774387774.239 sable_ircd #x1B[2m2026-03-24T21:29:34.239108Z#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) 1774387774.239 S -> chkSvs: ERROR :Client quit 1774387774.239 sable_ircd #x1B[2m2026-03-24T21:29:34.239255Z#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(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 824394534719852546, 99 => 824394534854471682) my clock=EventClock(1 => 824394534719852546, 99 => 824394534854471682) 1774387774.239 chkSvs: disconnects from server. 1774387774.240 1: connects to server. 1774387774.240 1 -> S: NICK foo 1774387774.240 1 -> S: USER r e g :user 1774387774.240 sable_ircd #x1B[2m2026-03-24T21:29:34.239553Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), 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:52131 (127.0.0.1:52131) 1774387774.240 sable_ircd #x1B[2m2026-03-24T21:29:34.239569Z#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 1774387774.240 sable_ircd #x1B[2m2026-03-24T21:29:34.239650Z#x1B[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 1774387774.240 sable_ircd #x1B[2m2026-03-24T21:29:34.240061Z#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 } 1774387774.240 sable_ircd #x1B[2m2026-03-24T21:29:34.240183Z#x1B[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 1774387774.240 sable_ircd #x1B[2m2026-03-24T21:29:34.240234Z#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 1774387774.240 sable_ircd #x1B[2m2026-03-24T21:29:34.240303Z#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 1774387774.241 sable_ircd #x1B[2m2026-03-24T21:29:34.240460Z#x1B[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 1774387774.241 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1774387774.241 sable_ircd #x1B[2m2026-03-24T21:29:34.240515Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK foo" 1774387774.241 sable_ircd #x1B[2m2026-03-24T21:29:34.240671Z#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: 531, tv_nsec: 835596939 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("foo")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1774387774.241 sable_ircd #x1B[2m2026-03-24T21:29:34.240759Z#x1B[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 1774387774.241 sable_ircd #x1B[2m2026-03-24T21:29:34.240815Z#x1B[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 1774387774.241 sable_ircd #x1B[2m2026-03-24T21:29:34.240863Z#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" 1774387774.241 sable_ircd #x1B[2m2026-03-24T21:29:34.240954Z#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: 531, tv_nsec: 835596939 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("foo")), realname: OnceLock(Realname("user")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1774387774.242 sable_ircd #x1B[2m2026-03-24T21:29:34.241550Z#x1B[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 1774387774.242 sable_ircd #x1B[2m2026-03-24T21:29:34.241587Z#x1B[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")) 1774387774.242 sable_ircd #x1B[2m2026-03-24T21:29:34.241626Z#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 1774387774.242 sable_ircd #x1B[2m2026-03-24T21:29:34.241665Z#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: 531, tv_nsec: 835596939 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("foo")), realname: OnceLock(Realname("user")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1774387774.242 sable_ircd #x1B[2m2026-03-24T21:29:34.241754Z#x1B[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)) 1774387774.242 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1774387774.242 sable_ircd #x1B[2m2026-03-24T21:29:34.242310Z#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(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 824394537454538755, 99 => 824394534854471682) my clock=EventClock(1 => 824394537454538755, 99 => 824394534854471682) 1774387774.243 sable_ircd #x1B[2m2026-03-24T21:29:34.242555Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), 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:52131 (127.0.0.1:52131) 1774387774.243 sable_ircd #x1B[2m2026-03-24T21:29:34.242674Z#x1B[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(824394537454538755)), timestamp: 1774387774, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(824394534715658240)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(824394534715658241)), user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 } }), users_to_notify: [] }) 1774387774.243 sable_ircd #x1B[2m2026-03-24T21:29:34.242767Z#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(824394537454538755)), timestamp: 1774387774, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(824394534715658240)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(824394534715658241)), user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 } }), users_to_notify: [] } 1774387774.243 sable_ircd #x1B[2m2026-03-24T21:29:34.242837Z#x1B[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(824394537454538755)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387774.243 sable_ircd #x1B[2m2026-03-24T21:29:34.242883Z#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(824394537454538755)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] } 1774387774.244 sable_ircd #x1B[2m2026-03-24T21:29:34.244324Z#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(824394537475510277)), timestamp: 1774387774, clock: EventClock(1 => 824394537467121668, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(824394537462927363)), NewUserConnection { user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 })) }) }; event clock=EventClock(1 => 824394537467121668, 99 => 824394534854471682) my clock=EventClock(1 => 824394537467121668, 99 => 824394534854471682) 1774387774.245 sable_ircd #x1B[2m2026-03-24T21:29:34.244633Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537475510277)), timestamp: 1774387774, clock: EventClock(1 => 824394537467121668, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(824394537462927363)), NewUserConnection { user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 })) }) }) } #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:52131 (127.0.0.1:52131) 1774387774.245 sable_ircd #x1B[2m2026-03-24T21:29:34.244817Z#x1B[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(824394537467121668)), timestamp: 1774387774, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(824394534715658240)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1774387774.245 sable_ircd #x1B[2m2026-03-24T21:29:34.244859Z#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(824394537467121668)), timestamp: 1774387774, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(824394534715658240)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1774387774.245 sable_ircd #x1B[2m2026-03-24T21:29:34.244920Z#x1B[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(824394537467121668)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387774.245 sable_ircd #x1B[2m2026-03-24T21:29:34.244952Z#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(824394537467121668)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] } 1774387774.248 sable_ircd #x1B[2m2026-03-24T21:29:34.248245Z#x1B[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(824394537475510277)), timestamp: 1774387774, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 1) }), users_to_notify: [] }) 1774387774.248 sable_ircd #x1B[2m2026-03-24T21:29:34.248286Z#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(824394537475510277)), timestamp: 1774387774, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 1) }), users_to_notify: [] } 1774387774.248 sable_ircd #x1B[2m2026-03-24T21:29:34.248356Z#x1B[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(824394537475510277)), timestamp: 1774387774, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 2), connection: UserConnectionId(Snowflake(824394537462927363)) }), users_to_notify: [] }) 1774387774.248 sable_ircd #x1B[2m2026-03-24T21:29:34.248393Z#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(824394537475510277)), timestamp: 1774387774, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 2), connection: UserConnectionId(Snowflake(824394537462927363)) }), users_to_notify: [] } 1774387774.248 sable_ircd #x1B[2m2026-03-24T21:29:34.248453Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo 1774387774.249 sable_ircd #x1B[2m2026-03-24T21:29:34.248495Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1774387774.249 sable_ircd #x1B[2m2026-03-24T21:29:34.248545Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 003 foo :This server was created 2026-03-24 21:29:34.248529199 UTC 1774387774.249 sable_ircd #x1B[2m2026-03-24T21:29:34.248590Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1774387774.249 sable_ircd #x1B[2m2026-03-24T21:29:34.248638Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 005 foo EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1774387774.249 sable_ircd #x1B[2m2026-03-24T21:29:34.248674Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 422 foo :MOTD File is missing 1774387774.249 sable_ircd #x1B[2m2026-03-24T21:29:34.248737Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :foo!r@localhost MODE foo + 1774387774.249 sable_ircd #x1B[2m2026-03-24T21:29:34.248779Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1774387774.249 sable_ircd #x1B[2m2026-03-24T21:29:34.248838Z#x1B[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(824394537475510277)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387774.249 sable_ircd #x1B[2m2026-03-24T21:29:34.248879Z#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(824394537475510277)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] } 1774387774.249 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo 1774387774.249 sable_services #x1B[2m2026-03-24T21:29:34.249133Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537475510277)), timestamp: 1774387774, clock: EventClock(1 => 824394537467121668, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(824394537462927363)), NewUserConnection { user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 })) }) }) } }#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(824394537475510277)), timestamp: 1774387774, clock: EventClock(1 => 824394537467121668, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(824394537462927363)), NewUserConnection { user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 })) }) }; event clock=EventClock(1 => 824394537467121668, 99 => 824394534854471682) my clock=EventClock(1 => 824394534245896193, 99 => 824394534854471682) 1774387774.249 sable_services #x1B[2m2026-03-24T21:29:34.249257Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537475510277)), timestamp: 1774387774, clock: EventClock(1 => 824394537467121668, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(824394537462927363)), NewUserConnection { user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 })) }) }) } }#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(824394537467121668))] 1774387774.250 sable_services #x1B[2m2026-03-24T21:29:34.249671Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537475510277)), timestamp: 1774387774, clock: EventClock(1 => 824394537467121668, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(824394537462927363)), NewUserConnection { user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 })) }) }) } }#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537475510277)), timestamp: 1774387774, clock: EventClock(1 => 824394537467121668, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(824394537462927363)), NewUserConnection { user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 })) }) }) } #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:57951 (127.0.0.1:57951) 1774387774.283 sable_services #x1B[2m2026-03-24T21:29:34.282920Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), 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 Deferring event Event { id: EventId(Snowflake(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 824394534719852546, 99 => 824394534854471682) my clock=EventClock(1 => 824394534245896193, 99 => 824394534854471682) 1774387774.283 sable_services #x1B[2m2026-03-24T21:29:34.282976Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), 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::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(824394534719852546))] 1774387774.283 sable_services #x1B[2m2026-03-24T21:29:34.283248Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), 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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), 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:57951 (127.0.0.1:57951) 1774387774.285 sable_services #x1B[2m2026-03-24T21:29:34.285147Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), 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(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 824394537454538755, 99 => 824394534854471682) my clock=EventClock(1 => 824394534245896193, 99 => 824394534854471682) 1774387774.285 sable_services #x1B[2m2026-03-24T21:29:34.285222Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), 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(824394537454538755))] 1774387774.286 sable_services #x1B[2m2026-03-24T21:29:34.285551Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), 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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), 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:57951 (127.0.0.1:57951) 1774387774.290 sable_ircd #x1B[2m2026-03-24T21:29:34.289897Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394537467121668))]) } }#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(824394537467121668))] 1774387774.290 sable_ircd #x1B[2m2026-03-24T21:29:34.289945Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394537467121668))]) } }#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(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1774387774.324 sable_ircd #x1B[2m2026-03-24T21:29:34.323846Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394534719852546))]) } }#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(824394534719852546))] 1774387774.324 sable_ircd #x1B[2m2026-03-24T21:29:34.323880Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394534719852546))]) } }#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(824394534719852546)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: User(UserId(Snowflake(824394534715658240))), 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(824394534715658241)), NewUserConnection { user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 })) }) }] 1774387774.327 sable_ircd #x1B[2m2026-03-24T21:29:34.326872Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394537454538755))]) } }#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(824394537454538755))] 1774387774.327 sable_ircd #x1B[2m2026-03-24T21:29:34.326915Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394537454538755))]) } }#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(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), details: UserDisconnect(UserDisconnect) }] 1774387774.332 sable_services #x1B[2m2026-03-24T21:29:34.331886Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), 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(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1774387774.332 sable_services #x1B[2m2026-03-24T21:29:34.331945Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), 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[0mfalse#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(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 824394537454538755, 99 => 824394534854471682) my clock=EventClock(1 => 824394534245896193, 99 => 824394534854471682) 1774387774.332 sable_services #x1B[2m2026-03-24T21:29:34.331986Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), 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[0mfalse#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(824394537454538755))] 1774387774.349 1 -> S: PING synchronize531.944598392 1774387774.349 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1774387774.349 S -> 1: :My.Little.Server 003 foo :This server was created 2026-03-24 21:29:34.248529199 UTC 1774387774.349 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1774387774.349 S -> 1: :My.Little.Server 005 foo EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1774387774.349 S -> 1: :My.Little.Server 422 foo :MOTD File is missing 1774387774.350 S -> 1: :foo!r@localhost MODE foo + 1774387774.350 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1774387774.350 sable_ircd #x1B[2m2026-03-24T21:29:34.349728Z#x1B[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 1774387774.350 sable_ircd #x1B[2m2026-03-24T21:29:34.349769Z#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 synchronize531.944598392" 1774387774.350 sable_ircd #x1B[2m2026-03-24T21:29:34.349854Z#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 :synchronize531.944598392 1774387774.350 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize531.944598392 1774387774.350 1 -> S: REGISTER * * éééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééé 1774387774.350 sable_ircd #x1B[2m2026-03-24T21:29:34.350402Z#x1B[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 1774387774.350 sable_ircd #x1B[2m2026-03-24T21:29:34.350441Z#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 * * éééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééé" 1774387774.351 sable_ircd #x1B[2m2026-03-24T21:29:34.350616Z#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:52131", fingerprint: "cf236c08427102385ed8e42755c27250e9ba28fd" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("foo"), "éééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééé")) } 1774387774.351 sable_ircd #x1B[2m2026-03-24T21:29:34.350876Z#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), 1774387773), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("foo"), "éééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééé")) }) } #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:52131 (127.0.0.1:52131) 1774387774.353 sable_ircd #x1B[2m2026-03-24T21:29:34.352451Z#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) }) 1774387774.365 sable_services #x1B[2m2026-03-24T21:29:34.364983Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394534719852546)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: User(UserId(Snowflake(824394534715658240))), 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(824394534715658241)), NewUserConnection { user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 })) }) }]) } }#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(824394534719852546)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: User(UserId(Snowflake(824394534715658240))), 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(824394534715658241)), NewUserConnection { user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 })) }) }] 1774387774.365 sable_services #x1B[2m2026-03-24T21:29:34.365066Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394534719852546)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: User(UserId(Snowflake(824394534715658240))), 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(824394534715658241)), NewUserConnection { user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 })) }) }]) } }#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[0mfalse#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(824394534719852546)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: User(UserId(Snowflake(824394534715658240))), 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(824394534715658241)), NewUserConnection { user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 })) }) }; event clock=EventClock(1 => 824394534245896193) my clock=EventClock(1 => 824394534245896193, 99 => 824394534854471682) 1774387774.365 sable_services #x1B[2m2026-03-24T21:29:34.365148Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394534719852546)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: User(UserId(Snowflake(824394534715658240))), 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(824394534715658241)), NewUserConnection { user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 })) }) }]) } }#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[0mfalse#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(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), details: UserDisconnect(UserDisconnect) } 1774387774.365 sable_services #x1B[2m2026-03-24T21:29:34.365198Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394534719852546)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: User(UserId(Snowflake(824394534715658240))), 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(824394534715658241)), NewUserConnection { user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 })) }) }]) } }#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[0mfalse#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(824394537467121668)), timestamp: 1774387774, clock: EventClock(1 => 824394537454538755, 99 => 824394534854471682), target: User(UserId(Snowflake(824394534715658240))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1774387774.365 sable_services #x1B[2m2026-03-24T21:29:34.365239Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394534719852546)), timestamp: 1774387773, clock: EventClock(1 => 824394534245896193), target: User(UserId(Snowflake(824394534715658240))), 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(824394534715658241)), NewUserConnection { user: UserId(Snowflake(824394534715658240)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387773 })) }) }]) } }#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[0mfalse#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(824394537475510277)), timestamp: 1774387774, clock: EventClock(1 => 824394537467121668, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: NewUser(NewUser { nickname: Nickname("foo"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(824394537462927363)), NewUserConnection { user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 })) }) } 1774387774.368 sable_services #x1B[2m2026-03-24T21:29:34.367919Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), 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(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), details: UserDisconnect(UserDisconnect) }] 1774387774.393 sable_services #x1B[2m2026-03-24T21:29:34.392956Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(RegisterUser(Nickname("foo"), "éééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééé")) 1774387774.393 sable_services #x1B[2m2026-03-24T21:29:34.393005Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got register request #x1B[3maccount_name#x1B[0m#x1B[2m=#x1B[0mNickname("foo") 1774387774.397 sable_services #x1B[2m2026-03-24T21:29:34.397311Z#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(824394538100862976)), name: Nickname("foo"), authorised_fingerprints: [] } 1774387774.398 sable_services #x1B[2m2026-03-24T21:29:34.397520Z#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(824394538117640195)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: Account(AccountId(Snowflake(824394538100862976))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(824394538100862976)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 824394537475510277, 99 => 824394534854471682) my clock=EventClock(1 => 824394537475510277, 99 => 824394534854471682) 1774387774.398 sable_services #x1B[2m2026-03-24T21:29:34.397827Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394538117640195)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: Account(AccountId(Snowflake(824394538100862976))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(824394538100862976)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:57951 (127.0.0.1:57951) 1774387774.439 sable_ircd #x1B[2m2026-03-24T21:29:34.438861Z#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), 1774387773), content: TargetedMessageResponse(Services(LogUserIn(AccountId(Snowflake(824394538100862976))))) } } 1774387774.439 sable_ircd #x1B[2m2026-03-24T21:29:34.439021Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394537454538755))]) } }#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(824394537454538755))] 1774387774.439 sable_ircd #x1B[2m2026-03-24T21:29:34.439076Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394537454538755))]) } }#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(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), details: UserDisconnect(UserDisconnect) }] 1774387774.439 sable_ircd #x1B[2m2026-03-24T21:29:34.439290Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): REGISTER SUCCESS foo :You have successfully registered 1774387774.439 sable_ircd #x1B[2m2026-03-24T21:29:34.439361Z#x1B[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 1774387774.439 sable_ircd #x1B[2m2026-03-24T21:29:34.439415Z#x1B[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(824394537462927362))), UserLogin(UserLogin { account: Some(AccountId(Snowflake(824394538100862976))) })) 1774387774.440 sable_ircd #x1B[2m2026-03-24T21:29:34.439564Z#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(824394538293399558)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(824394538100862976))) }) }; event clock=EventClock(1 => 824394537475510277, 99 => 824394534854471682) my clock=EventClock(1 => 824394537475510277, 99 => 824394534854471682) 1774387774.440 sable_ircd #x1B[2m2026-03-24T21:29:34.440064Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394538293399558)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(824394538100862976))) }) }) } #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:52131 (127.0.0.1:52131) 1774387774.442 sable_ircd #x1B[2m2026-03-24T21:29:34.442021Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394538117640195)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: Account(AccountId(Snowflake(824394538100862976))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(824394538100862976)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(824394538117640195)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: Account(AccountId(Snowflake(824394538100862976))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(824394538100862976)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 824394537475510277, 99 => 824394534854471682) my clock=EventClock(1 => 824394538293399558, 99 => 824394534854471682) 1774387774.442 sable_ircd #x1B[2m2026-03-24T21:29:34.442409Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394538117640195)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: Account(AccountId(Snowflake(824394538100862976))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(824394538100862976)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394538117640195)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: Account(AccountId(Snowflake(824394538100862976))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(824394538100862976)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:52131 (127.0.0.1:52131) 1774387774.443 sable_ircd #x1B[2m2026-03-24T21:29:34.442543Z#x1B[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(824394538293399558)), timestamp: 1774387774, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 3), old_account: None, new_account: Some(AccountId(Snowflake(824394538100862976))) }), users_to_notify: [] }) 1774387774.443 sable_ircd #x1B[2m2026-03-24T21:29:34.442596Z#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(824394538293399558)), timestamp: 1774387774, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 3), old_account: None, new_account: Some(AccountId(Snowflake(824394538100862976))) }), users_to_notify: [] } 1774387774.443 sable_ircd #x1B[2m2026-03-24T21:29:34.442639Z#x1B[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(824394538293399558)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387774.443 sable_ircd #x1B[2m2026-03-24T21:29:34.442658Z#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(824394538293399558)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] } 1774387774.445 sable_ircd #x1B[2m2026-03-24T21:29:34.444378Z#x1B[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(824394538117640195)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387774.445 sable_ircd #x1B[2m2026-03-24T21:29:34.444421Z#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(824394538117640195)), timestamp: 1774387774, change: EventComplete(EventComplete), users_to_notify: [] } 1774387774.480 sable_services #x1B[2m2026-03-24T21:29:34.479934Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), 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(824394537454538755)), timestamp: 1774387774, clock: EventClock(1 => 824394534719852546, 99 => 824394534854471682), target: UserConnection(UserConnectionId(Snowflake(824394534715658241))), details: UserDisconnect(UserDisconnect) }] 1774387774.483 sable_services #x1B[2m2026-03-24T21:29:34.482885Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394538293399558)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(824394538100862976))) }) }) } }#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(824394538293399558)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(824394538100862976))) }) }; event clock=EventClock(1 => 824394537475510277, 99 => 824394534854471682) my clock=EventClock(1 => 824394537475510277, 99 => 824394538117640195) 1774387774.483 sable_services #x1B[2m2026-03-24T21:29:34.483120Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394538293399558)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(824394538100862976))) }) }) } }#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394538293399558)), timestamp: 1774387774, clock: EventClock(1 => 824394537475510277, 99 => 824394534854471682), target: User(UserId(Snowflake(824394537462927362))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(824394538100862976))) }) }) } #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:57951 (127.0.0.1:57951) 1774387774.550 1 -> S: PING synchronize532.145659509 1774387774.550 S -> 1: REGISTER SUCCESS foo :You have successfully registered 1774387774.551 sable_ircd #x1B[2m2026-03-24T21:29:34.550745Z#x1B[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 1774387774.551 sable_ircd #x1B[2m2026-03-24T21:29:34.550800Z#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 synchronize532.145659509" 1774387775.053 sable_ircd #x1B[2m2026-03-24T21:29:35.052898Z#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 :synchronize532.145659509 1774387775.053 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize532.145659509 1774387775.053 1 -> S: QUIT 1774387775.054 sable_ircd #x1B[2m2026-03-24T21:29:35.053654Z#x1B[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 1774387775.054 sable_ircd #x1B[2m2026-03-24T21:29:35.053745Z#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" 1774387775.154 1 -> S: PING synchronize532.748781667 1774387775.154 sable_ircd #x1B[2m2026-03-24T21:29:35.153902Z#x1B[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 1774387775.154 sable_ircd #x1B[2m2026-03-24T21:29:35.153961Z#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 synchronize532.748781667" 1774387776.154 1: waiting… 1774387776.159 sable_ircd #x1B[2m2026-03-24T21:29:36.159250Z#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 1774387776.159 sable_ircd #x1B[2m2026-03-24T21:29:36.159373Z#x1B[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)) 1774387776.159 sable_ircd #x1B[2m2026-03-24T21:29:36.159405Z#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) 1774387776.160 sable_ircd #x1B[2m2026-03-24T21:29:36.159550Z#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(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 824394538293399558, 99 => 824394538117640195) my clock=EventClock(1 => 824394538293399558, 99 => 824394538117640195) 1774387776.160 S -> 1: ERROR :Client quit 1774387776.160 sable_ircd #x1B[2m2026-03-24T21:29:36.159844Z#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 1774387776.160 sable_ircd #x1B[2m2026-03-24T21:29:36.159934Z#x1B[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 1774387776.160 sable_ircd #x1B[2m2026-03-24T21:29:36.159947Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), 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:52131 (127.0.0.1:52131) 1774387776.162 sable_ircd #x1B[2m2026-03-24T21:29:36.161681Z#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(824394545515991048)), timestamp: 1774387776, clock: EventClock(1 => 824394545507602439, 99 => 824394538117640195), target: User(UserId(Snowflake(824394537462927362))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 824394545507602439, 99 => 824394538117640195) my clock=EventClock(1 => 824394545507602439, 99 => 824394538117640195) 1774387776.162 sable_ircd #x1B[2m2026-03-24T21:29:36.161968Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545515991048)), timestamp: 1774387776, clock: EventClock(1 => 824394545507602439, 99 => 824394538117640195), target: User(UserId(Snowflake(824394537462927362))), 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:52131 (127.0.0.1:52131) 1774387776.162 sable_ircd #x1B[2m2026-03-24T21:29:36.162107Z#x1B[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(824394545507602439)), timestamp: 1774387776, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(824394537462927363)), user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 } }), users_to_notify: [] }) 1774387776.162 sable_ircd #x1B[2m2026-03-24T21:29:36.162151Z#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(824394545507602439)), timestamp: 1774387776, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(824394537462927363)), user: UserId(Snowflake(824394537462927362)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774387774 } }), users_to_notify: [] } 1774387776.162 sable_ircd #x1B[2m2026-03-24T21:29:36.162199Z#x1B[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(824394545507602439)), timestamp: 1774387776, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387776.162 sable_ircd #x1B[2m2026-03-24T21:29:36.162224Z#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(824394545507602439)), timestamp: 1774387776, change: EventComplete(EventComplete), users_to_notify: [] } 1774387776.166 sable_ircd #x1B[2m2026-03-24T21:29:36.165643Z#x1B[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(824394545515991048)), timestamp: 1774387776, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 3), nickname: Nickname("foo"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1774387776.166 sable_ircd #x1B[2m2026-03-24T21:29:36.165709Z#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(824394545515991048)), timestamp: 1774387776, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(824394537462927362)), 3), nickname: Nickname("foo"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1774387776.166 sable_ircd #x1B[2m2026-03-24T21:29:36.165783Z#x1B[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(824394545515991048)), timestamp: 1774387776, change: EventComplete(EventComplete), users_to_notify: [] }) 1774387776.166 sable_ircd #x1B[2m2026-03-24T21:29:36.165819Z#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(824394545515991048)), timestamp: 1774387776, change: EventComplete(EventComplete), users_to_notify: [] } 1774387776.166 sable_services #x1B[2m2026-03-24T21:29:36.166321Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545515991048)), timestamp: 1774387776, clock: EventClock(1 => 824394545507602439, 99 => 824394538117640195), target: User(UserId(Snowflake(824394537462927362))), 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(824394545515991048)), timestamp: 1774387776, clock: EventClock(1 => 824394545507602439, 99 => 824394538117640195), target: User(UserId(Snowflake(824394537462927362))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 824394545507602439, 99 => 824394538117640195) my clock=EventClock(1 => 824394538293399558, 99 => 824394538117640195) 1774387776.166 sable_services #x1B[2m2026-03-24T21:29:36.166372Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545515991048)), timestamp: 1774387776, clock: EventClock(1 => 824394545507602439, 99 => 824394538117640195), target: User(UserId(Snowflake(824394537462927362))), 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(824394545507602439))] 1774387776.167 sable_services #x1B[2m2026-03-24T21:29:36.166633Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545515991048)), timestamp: 1774387776, clock: EventClock(1 => 824394545507602439, 99 => 824394538117640195), target: User(UserId(Snowflake(824394537462927362))), 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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545515991048)), timestamp: 1774387776, clock: EventClock(1 => 824394545507602439, 99 => 824394538117640195), target: User(UserId(Snowflake(824394537462927362))), 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:57951 (127.0.0.1:57951) 1774387776.204 sable_services #x1B[2m2026-03-24T21:29:36.202964Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), 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(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 824394538293399558, 99 => 824394538117640195) my clock=EventClock(1 => 824394538293399558, 99 => 824394538117640195) 1774387776.204 sable_services #x1B[2m2026-03-24T21:29:36.203049Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), 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(824394545515991048)), timestamp: 1774387776, clock: EventClock(1 => 824394545507602439, 99 => 824394538117640195), target: User(UserId(Snowflake(824394537462927362))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1774387776.204 sable_services #x1B[2m2026-03-24T21:29:36.203350Z#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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), 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), 1774387773), content: NewEvent(Event { id: EventId(Snowflake(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), 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:57951 (127.0.0.1:57951) 1774387776.208 sable_ircd #x1B[2m2026-03-24T21:29:36.208318Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394545507602439))]) } }#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(824394545507602439))] 1774387776.208 sable_ircd #x1B[2m2026-03-24T21:29:36.208362Z#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), 1774387773), content: GetEvent([EventId(Snowflake(824394545507602439))]) } }#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(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), details: UserDisconnect(UserDisconnect) }] 1774387776.249 sable_services #x1B[2m2026-03-24T21:29:36.248913Z#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), 1774387773), content: BulkEvents([Event { id: EventId(Snowflake(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), 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(824394545507602439)), timestamp: 1774387776, clock: EventClock(1 => 824394538293399558, 99 => 824394538117640195), target: UserConnection(UserConnectionId(Snowflake(824394537462927363))), details: UserDisconnect(UserDisconnect) }] 1774387776.260 1 -> S: PING synchronize533.85513309 1774387776.260 1: connects to server. 1774387776.260 1 -> S: CAP REQ :sasl 1774387776.261 sable_ircd #x1B[2m2026-03-24T21:29:36.260554Z#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 } 1774387776.261 sable_ircd #x1B[2m2026-03-24T21:29:36.260666Z#x1B[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 1774387776.261 sable_ircd #x1B[2m2026-03-24T21:29:36.260731Z#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 1774387776.261 sable_ircd #x1B[2m2026-03-24T21:29:36.260783Z#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 1774387776.261 sable_ircd #x1B[2m2026-03-24T21:29:36.260904Z#x1B[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 1774387776.261 sable_ircd #x1B[2m2026-03-24T21:29:36.260960Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP REQ :sasl" 1774387776.261 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1774387776.261 sable_ircd #x1B[2m2026-03-24T21:29:36.261120Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server CAP * ACK :sasl 1774387776.261 sable_ircd #x1B[2m2026-03-24T21:29:36.261184Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mUpdateConnectionCaps(ConnectionId(ListenerId(0), 4), ClientCapabilitySet(8)) 1774387776.261 S -> 1: :My.Little.Server CAP * ACK :sasl 1774387776.262 1 -> S: AUTHENTICATE PLAIN 1774387776.262 sable_ircd #x1B[2m2026-03-24T21:29:36.261822Z#x1B[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 1774387776.262 sable_ircd #x1B[2m2026-03-24T21:29:36.261859Z#x1B[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")) 1774387776.262 sable_ircd #x1B[2m2026-03-24T21:29:36.261899Z#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 1774387776.262 sable_ircd #x1B[2m2026-03-24T21:29:36.261935Z#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: 533, tv_nsec: 856081769 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1774387776.262 sable_ircd #x1B[2m2026-03-24T21:29:36.262168Z#x1B[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 1774387776.262 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1774387776.262 sable_ircd #x1B[2m2026-03-24T21:29:36.262220Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"AUTHENTICATE PLAIN" 1774387776.262 sable_ircd #x1B[2m2026-03-24T21:29:36.262379Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::command::handlers::services::sasl#x1B[0m#x1B[2m:#x1B[0m Beginning new SASL session #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(824394545939615748)) 1774387776.263 sable_ircd #x1B[2m2026-03-24T21:29:36.262491Z#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:52131", fingerprint: "cf236c08427102385ed8e42755c27250e9ba28fd" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(824394545939615748)), "PLAIN")) } 1774387776.263 sable_ircd #x1B[2m2026-03-24T21:29:36.262713Z#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), 1774387773), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(824394545939615748)), "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:52131 (127.0.0.1:52131) 1774387776.265 sable_ircd #x1B[2m2026-03-24T21:29:36.264651Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(35) }) 1774387776.306 sable_services #x1B[2m2026-03-24T21:29:36.306027Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(BeginAuthenticate(SaslSessionId(Snowflake(824394545939615748)), "PLAIN")) 1774387776.306 sable_services #x1B[2m2026-03-24T21:29:36.306082Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got begin authenticate #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(824394545939615748)) #x1B[3mmechanism#x1B[0m#x1B[2m=#x1B[0m"PLAIN" 1774387776.347 sable_ircd #x1B[2m2026-03-24T21:29:36.346868Z#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), 1774387773), content: TargetedMessageResponse(Services(Authenticate(InProgress([])))) } } 1774387776.347 sable_ircd #x1B[2m2026-03-24T21:29:36.347024Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): AUTHENTICATE :+ 1774387776.347 sable_ircd #x1B[2m2026-03-24T21:29:36.347105Z#x1B[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 1774387776.347 S -> 1: AUTHENTICATE :+ 1774387776.348 1 -> S: AUTHENTICATE Zm9vAGZvbwDDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqQ== 1774387776.348 sable_ircd #x1B[2m2026-03-24T21:29:36.347826Z#x1B[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 1774387776.348 sable_ircd #x1B[2m2026-03-24T21:29:36.347867Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"AUTHENTICATE Zm9vAGZvbwDDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqQ==" 1774387776.348 sable_ircd #x1B[2m2026-03-24T21:29:36.347987Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::command::handlers::services::sasl#x1B[0m#x1B[2m:#x1B[0m Resuming SASL session #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(824394545939615748)) 1774387776.348 sable_ircd #x1B[2m2026-03-24T21:29:36.348105Z#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:52131", fingerprint: "cf236c08427102385ed8e42755c27250e9ba28fd" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(Authenticate(SaslSessionId(Snowflake(824394545939615748)), [102, 111, 111, 0, 102, 111, 111, 0, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169])) } 1774387776.348 sable_ircd #x1B[2m2026-03-24T21:29:36.348329Z#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), 1774387773), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(Authenticate(SaslSessionId(Snowflake(824394545939615748)), [102, 111, 111, 0, 102, 111, 111, 0, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169])) }) } #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:52131 (127.0.0.1:52131) 1774387776.350 sable_ircd #x1B[2m2026-03-24T21:29:36.350016Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(36) }) 1774387776.392 sable_services #x1B[2m2026-03-24T21:29:36.392072Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(Authenticate(SaslSessionId(Snowflake(824394545939615748)), [102, 111, 111, 0, 102, 111, 111, 0, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169])) 1774387776.392 sable_services #x1B[2m2026-03-24T21:29:36.392126Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got authenticate data #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(824394545939615748)) #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0m[102, 111, 111, 0, 102, 111, 111, 0, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169, 195, 169] 1774387776.396 sable_services #x1B[2m2026-03-24T21:29:36.395842Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server::sasl::plain#x1B[0m#x1B[2m:#x1B[0m sasl login successful #x1B[3maccount_name#x1B[0m#x1B[2m=#x1B[0mNickname("foo") 1774387776.437 sable_ircd #x1B[2m2026-03-24T21:29:36.436908Z#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), 1774387773), content: TargetedMessageResponse(Services(Authenticate(Success(AccountId(Snowflake(824394538100862976)))))) } } 1774387776.437 sable_ircd #x1B[2m2026-03-24T21:29:36.437057Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 900 * * foo :You are now logged in as foo 1774387776.437 sable_ircd #x1B[2m2026-03-24T21:29:36.437111Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 903 * :SASL authentication successful 1774387776.437 sable_ircd #x1B[2m2026-03-24T21:29:36.437167Z#x1B[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 1774387776.438 S -> 1: :My.Little.Server 900 * * foo :You are now logged in as foo 1774387776.440 sable_ircd #x1B[2m2026-03-24T21:29:36.439850Z#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 1774387776.440 sable_ircd #x1B[2m2026-03-24T21:29:36.440052Z#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:57951, peer: 127.0.0.1:34753, fd: 19 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x560e70a0a990, 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 1774387776.440 sable_ircd #x1B[2m2026-03-24T21:29:36.440094Z#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 1774387776.440 sable_ircd #x1B[2m2026-03-24T21:29:36.440094Z#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 1774387776.443 1: disconnects from server.