--------------------------------- Captured Out --------------------------------- ---- new test ---- 1788127875.535 sable_ircd uid=1001 1788127875.535 sable_services uid=1001 1788127875.536 sable_services #x1B[2m2026-08-30T22:11:15.536247Z#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:40315", fingerprint: "877cf546dfe3f216d617c8d3b8df1056db1f1826" } 1788127875.537 sable_services #x1B[2m2026-08-30T22:11:15.536564Z#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), 1788127875), 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:40315. Last error: I/O error: Connection refused (os error 111) 1788127875.537 sable_services #x1B[2m2026-08-30T22:11:15.536626Z#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), 1788127875), 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) 1788127875.539 sable_ircd #x1B[2m2026-08-30T22:11:15.539321Z#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(882024699297533952)), timestamp: 1788127875, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Server"), ts: 1788127875, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1788127875.539 sable_ircd #x1B[2m2026-08-30T22:11:15.539437Z#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 1788127875.540 sable_ircd #x1B[2m2026-08-30T22:11:15.539576Z#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(882024699297533952)), timestamp: 1788127875, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Server"), ts: 1788127875, 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 1788127875.540 sable_ircd #x1B[2m2026-08-30T22:11:15.539674Z#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(882024699297533953)), timestamp: 1788127875, clock: EventClock(1 => 882024699297533952), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127875 }) }; event clock=EventClock(1 => 882024699297533952) my clock=EventClock(1 => 882024699297533952) 1788127875.540 sable_ircd #x1B[2m2026-08-30T22:11:15.539734Z#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 1788127875.540 sable_ircd #x1B[2m2026-08-30T22:11:15.539909Z#x1B[0m #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(882024699297533952)), timestamp: 1788127875, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1788127875.540 sable_ircd #x1B[2m2026-08-30T22:11:15.539941Z#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(882024699297533952)), timestamp: 1788127875, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1788127875.540 sable_ircd #x1B[2m2026-08-30T22:11:15.539964Z#x1B[0m #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(882024699297533952)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127875.540 sable_ircd #x1B[2m2026-08-30T22:11:15.539984Z#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(882024699297533952)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] } 1788127875.540 sable_ircd #x1B[2m2026-08-30T22:11:15.540007Z#x1B[0m #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(882024699297533953)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127875.540 sable_ircd #x1B[2m2026-08-30T22:11:15.540023Z#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(882024699297533953)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] } 1788127875.541 sable_ircd #x1B[2m2026-08-30T22:11:15.541185Z#x1B[0m #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 1788127875.622 sable_services #x1B[2m2026-08-30T22:11:15.622044Z#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:40315", fingerprint: "877cf546dfe3f216d617c8d3b8df1056db1f1826" } 1788127875.622 sable_services #x1B[2m2026-08-30T22:11:15.622234Z#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), 1788127875), 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:40315. Last error: I/O error: Connection refused (os error 111) 1788127875.622 sable_services #x1B[2m2026-08-30T22:11:15.622263Z#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), 1788127875), 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) 1788127875.632 sable_history #x1B[2m2027-08-30T23:25:02.100876Z#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(1014314836580048979)), timestamp: 1819668302, clock: EventClock(1 => 1014295448346693654, 50 => 1014314584921808978, 99 => 1014295451547348996), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819668302 }) }; event clock=EventClock(1 => 1014295448346693654, 50 => 1014314584921808978, 99 => 1014295451547348996) my clock=EventClock(1 => 1014295448346693654, 50 => 1014314584921808978, 99 => 1014295451547348996) 1788127875.632 sable_history #x1B[2m2027-08-30T23:25:02.102356Z#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 1788127875.632 sable_ircd #x1B[2m2026-08-30T22:11:15.632006Z#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 } 1788127875.632 sable_ircd #x1B[2m2026-08-30T22:11:15.632118Z#x1B[0m #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 1788127875.632 sable_ircd #x1B[2m2026-08-30T22:11:15.632158Z#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 1788127875.632 sable_ircd #x1B[2m2026-08-30T22:11:15.632229Z#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 1788127875.632 sable_ircd #x1B[2m2026-08-30T22:11:15.632375Z#x1B[0m #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 1788127875.632 sable_ircd #x1B[2m2026-08-30T22:11:15.632437Z#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" 1788127875.633 sable_ircd #x1B[2m2026-08-30T22:11:15.632540Z#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 1788127875.633 sable_ircd #x1B[2m2026-08-30T22:11:15.632613Z#x1B[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)) 1788127875.633 sable_ircd #x1B[2m2026-08-30T22:11:15.632642Z#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) 1788127875.633 sable_ircd #x1B[2m2026-08-30T22:11:15.633028Z#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 1788127875.633 sable_ircd #x1B[2m2026-08-30T22:11:15.633075Z#x1B[0m #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 1788127875.633 sable_ircd #x1B[2m2026-08-30T22:11:15.633199Z#x1B[0m #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 1788127875.649 sable_history #x1B[2m2027-08-30T23:13:50.148036Z#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(1014312018209087559)), timestamp: 1819667630, clock: EventClock(1 => 1014295224354082831, 50 => 1014311766550847558, 99 => 1014295214413983748), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667630 }) }; event clock=EventClock(1 => 1014295224354082831, 50 => 1014311766550847558, 99 => 1014295214413983748) my clock=EventClock(1 => 1014295224354082831, 50 => 1014311766550847558, 99 => 1014295214413983748) 1788127875.649 sable_history #x1B[2m2027-08-30T23:13:50.149074Z#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 1788127875.653 chkSvs: connects to server. 1788127875.653 chkSvs -> S: NICK chkSvs 1788127875.653 chkSvs -> S: USER chk chk chk chk 1788127875.653 sable_ircd #x1B[2m2026-08-30T22:11:15.653256Z#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 } 1788127875.653 sable_ircd #x1B[2m2026-08-30T22:11:15.653336Z#x1B[0m #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 1788127875.653 sable_ircd #x1B[2m2026-08-30T22:11:15.653358Z#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 1788127875.653 sable_ircd #x1B[2m2026-08-30T22:11:15.653416Z#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 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.653522Z#x1B[0m #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 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.653557Z#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" 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.653687Z#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: 521, tv_nsec: 775020094 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.653734Z#x1B[0m #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 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.653748Z#x1B[0m #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 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.653764Z#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" 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.653805Z#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: 521, tv_nsec: 775020094 }, 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 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.654152Z#x1B[0m #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 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.654181Z#x1B[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")) 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.654203Z#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 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.654218Z#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: 521, tv_nsec: 775020094 }, 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 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.654247Z#x1B[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)) 1788127875.654 sable_ircd #x1B[2m2026-08-30T22:11:15.654431Z#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(882024699779878914)), timestamp: 1788127875, clock: EventClock(1 => 882024699297533953), target: User(UserId(Snowflake(882024699779878912))), 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(882024699779878913)), NewUserConnection { user: UserId(Snowflake(882024699779878912)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127875 })) }) }; event clock=EventClock(1 => 882024699297533953) my clock=EventClock(1 => 882024699297533953) 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654509Z#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 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654710Z#x1B[0m #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(882024699779878914)), timestamp: 1788127875, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024699779878912)), 1) }), users_to_notify: [] }) 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654739Z#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(882024699779878914)), timestamp: 1788127875, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024699779878912)), 1) }), users_to_notify: [] } 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654777Z#x1B[0m #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(882024699779878914)), timestamp: 1788127875, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024699779878912)), 2), connection: UserConnectionId(Snowflake(882024699779878913)) }), users_to_notify: [] }) 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654796Z#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(882024699779878914)), timestamp: 1788127875, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024699779878912)), 2), connection: UserConnectionId(Snowflake(882024699779878913)) }), users_to_notify: [] } 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654840Z#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 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654862Z#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 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654892Z#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-08-30 22:11:15.654878543 UTC 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654910Z#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 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654944Z#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 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654962Z#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 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654982Z#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 + 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.654997Z#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. 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.655037Z#x1B[0m #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(882024699779878914)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127875.655 sable_ircd #x1B[2m2026-08-30T22:11:15.655056Z#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(882024699779878914)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] } 1788127875.753 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127875.753 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127875.753 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1788127875.753 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127875.753 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2026-08-30 22:11:15.654878543 UTC 1788127875.753 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127875.753 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 1788127875.753 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing 1788127875.753 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs + 1788127875.753 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127875.753 chkSvs -> S: CAP LS 302 1788127875.754 sable_ircd #x1B[2m2026-08-30T22:11:15.753794Z#x1B[0m #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 1788127875.754 sable_ircd #x1B[2m2026-08-30T22:11:15.753852Z#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" 1788127875.754 sable_ircd #x1B[2m2026-08-30T22:11:15.753976Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1788127875.804 chkSvs -> S: PING synchronize521.925085034 1788127875.804 S -> chkSvs: :My.Little.Server CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1788127875.804 sable_ircd #x1B[2m2026-08-30T22:11:15.803906Z#x1B[0m #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 1788127875.804 sable_ircd #x1B[2m2026-08-30T22:11:15.803956Z#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 synchronize521.925085034" 1788127875.804 sable_ircd #x1B[2m2026-08-30T22:11:15.804052Z#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 :synchronize521.925085034 1788127875.804 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize521.925085034 1788127875.804 chkSvs -> S: CAP LS 302 1788127875.804 sable_ircd #x1B[2m2026-08-30T22:11:15.804457Z#x1B[0m #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 1788127875.805 sable_ircd #x1B[2m2026-08-30T22:11:15.804485Z#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" 1788127875.843 sable_services #x1B[2m2026-08-30T22:11:15.842887Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.Server"), address: "127.0.0.1:42123", fingerprint: "27f3a01706c9cadbdde8d1b08a4bed43211afea0" } (attempt #3). 1788127875.843 sable_services #x1B[2m2026-08-30T22:11:15.842927Z#x1B[0m #x1B[33m WARN#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Make sure at least one node in your network is started and reachable. If this is the first (or only) node, you must provide the --bootstrap-network option. 1788127875.843 sable_services #x1B[2m2026-08-30T22:11:15.843120Z#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), 1788127875), 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:42123 (127.0.0.1:42123) 1788127875.847 sable_ircd #x1B[2m2026-08-30T22:11:15.847040Z#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 1788127875.854 chkSvs -> S: PING synchronize521.97599786 1788127875.855 sable_ircd #x1B[2m2026-08-30T22:11:15.854734Z#x1B[0m #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 1788127875.855 sable_ircd #x1B[2m2026-08-30T22:11:15.854767Z#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 synchronize521.97599786" 1788127875.889 sable_services #x1B[2m2026-08-30T22:11:15.889113Z#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), 1788127875), content: NetworkState(Network { nick_bindings: {Nickname("chkSvs"): NickBinding { nick: Nickname("chkSvs"), user: UserId(Snowflake(882024699779878912)), timestamp: 1788127875, created: EventId(Snowflake(882024699779878914)) }}, historic_nick_users: HistoricNickStore { data: {} }, users: {UserId(Snowflake(882024699779878912)): User { id: UserId(Snowflake(882024699779878912)), serial: 2, user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, mode: UserMode { modes: UserModeSet(0) }, oper_privileges: None, account: None, session_key: None }}, historic_users: HistoricUserStore { users: {HistoricUserId(UserId(Snowflake(882024699779878912)), 1): HistoricUser { id: UserId(Snowflake(882024699779878912)), serial: 1, nickname: Nickname("chkSvs"), user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, account: None, timestamp: Some(1788127875) }, HistoricUserId(UserId(Snowflake(882024699779878912)), 2): HistoricUser { id: UserId(Snowflake(882024699779878912)), serial: 2, nickname: Nickname("chkSvs"), user: Username("chk"), visible_host: Hostname("localhost"), realname: Realname("chk"), away_reason: None, account: None, timestamp: None }} }, user_connections: {UserConnectionId(Snowflake(882024699779878913)): UserConnection { id: UserConnectionId(Snowflake(882024699779878913)), user: UserId(Snowflake(882024699779878912)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127875 }}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1788127875, name: ServerName("My.Little.Server"), last_ping: 1788127875, 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: {"nick": (1, String(_)), "ip": (0, Ip(_)), "user_param_1": (4, String(_)), "host": (3, String(_)), "realname": (2, String(_)), "user_param_2": (0, String(_)), "user": (5, String(_)), "tls": (0, Boolean(_))} }, new_connection_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [], uint64: [], regex: [] }, fields: {"tls": (0, Boolean(_)), "ip": (0, Ip(_))} }, pre_sasl_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [""], uint64: [], regex: [] }, fields: {"tls": (0, Boolean(_)), "mechanism": (0, String(_)), "ip": (0, Ip(_))} } }, audit_log: {}, accounts: {}, nick_registrations: {}, channel_registrations: {}, channel_accesses: {}, channel_roles: {}, current_services: None, current_history_server_id: None, config: NetworkConfig { opers: [OperConfig { name: "operuser", hash: "$6$z5yA.OfGliDoi/R2$BgSsguS6bxAsPSCygDisgDw5JZuo5.88eU3Hyc7/4OaNpeKIxWGjOggeHzOl0xLiZg1vfwxXjOTFN14wG5vNI." }], debug_mode: true, default_roles: {BuiltinOp: ChannelAccessSet(222192934775), BuiltinVoice: ChannelAccessSet(4296081441), BuiltinAll: ChannelAccessSet(1114112)}, alias_users: [AliasUser { nick: Nickname("ChanServ"), user: Username("ChanServ"), host: Hostname("services."), realname: Realname("Channel services compatibility layer"), command_alias: "CS" }, AliasUser { nick: Nickname("NickServ"), user: Username("NickServ"), host: Hostname("services."), realname: Realname("Account services compatibility layer"), command_alias: "NS" }], object_expiry: 60, pingout_duration: 600 }, clock: EventClock(1 => 882024699779878914), cache_default_channel_roles: OnceLock(), alias_users: OnceLock() }) } 1788127875.889 sable_services #x1B[2m2026-08-30T22:11:15.889288Z#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 1788127875.889 sable_services #x1B[2m2026-08-30T22:11:15.889408Z#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 1788127875.890 sable_services #x1B[2m2026-08-30T22:11:15.889932Z#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(882024700765941760)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Services"), ts: 1788127875, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 882024699779878914) my clock=EventClock(1 => 882024699779878914) 1788127875.890 sable_services #x1B[2m2026-08-30T22:11:15.890195Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700765941760)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Services"), ts: 1788127875, 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:42123 (127.0.0.1:42123) 1788127875.892 sable_services #x1B[2m2026-08-30T22:11:15.891553Z#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(882024700774330369)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700765941760), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127875 }) }; event clock=EventClock(1 => 882024699779878914, 99 => 882024700765941760) my clock=EventClock(1 => 882024699779878914, 99 => 882024700765941760) 1788127875.892 sable_services #x1B[2m2026-08-30T22:11:15.891765Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700774330369)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700765941760), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127875 }) }) } #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:42123 (127.0.0.1:42123) 1788127875.892 sable_services #x1B[2m2026-08-30T22:11:15.891837Z#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(882024700765941760)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Services"), ts: 1788127875, 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 1788127875.894 sable_services #x1B[2m2026-08-30T22:11:15.894437Z#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(882024700786913282)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700774330369), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 882024699779878914, 99 => 882024700774330369) my clock=EventClock(1 => 882024699779878914, 99 => 882024700774330369) 1788127875.895 sable_services #x1B[2m2026-08-30T22:11:15.894655Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700786913282)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700774330369), 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:42123 (127.0.0.1:42123) 1788127875.895 sable_ircd #x1B[2m2026-08-30T22:11:15.895220Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700774330369)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700765941760), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127875 }) }) } }#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(882024700774330369)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700765941760), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127875 }) }; event clock=EventClock(1 => 882024699779878914, 99 => 882024700765941760) my clock=EventClock(1 => 882024699779878914) 1788127875.895 sable_ircd #x1B[2m2026-08-30T22:11:15.895271Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700774330369)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700765941760), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127875 }) }) } }#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(882024700765941760))] 1788127875.895 sable_ircd #x1B[2m2026-08-30T22:11:15.895306Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700774330369)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700765941760), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127875 }) }) } }#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 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.932753Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700765941760)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Services"), ts: 1788127875, 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(882024700765941760)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Services"), ts: 1788127875, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 882024699779878914) my clock=EventClock(1 => 882024699779878914) 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.932817Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700765941760)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Services"), ts: 1788127875, 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(882024700774330369)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700765941760), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1788127875 }) } 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.932851Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700765941760)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Services"), ts: 1788127875, 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 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.933041Z#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(882024700765941760)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1788127875, name: ServerName("My.Little.Services"), ts: 1788127875, 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 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.933192Z#x1B[0m #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(882024700765941760)), timestamp: 1788127875, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }) 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.933226Z#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(882024700765941760)), timestamp: 1788127875, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] } 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.933282Z#x1B[0m #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(882024700765941760)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.933303Z#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(882024700765941760)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] } 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.933332Z#x1B[0m #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(882024700774330369)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127875.933 sable_ircd #x1B[2m2026-08-30T22:11:15.933348Z#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(882024700774330369)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] } 1788127875.937 sable_services #x1B[2m2026-08-30T22:11:15.936599Z#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), 1788127875), content: GetEvent([EventId(Snowflake(882024700765941760))]) } }#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(882024700765941760))] 1788127875.937 sable_services #x1B[2m2026-08-30T22:11:15.936632Z#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), 1788127875), content: GetEvent([EventId(Snowflake(882024700765941760))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [] 1788127875.937 sable_ircd #x1B[2m2026-08-30T22:11:15.936722Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700786913282)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700774330369), 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(882024700786913282)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700774330369), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 882024699779878914, 99 => 882024700774330369) my clock=EventClock(1 => 882024699779878914, 99 => 882024700774330369) 1788127875.937 sable_ircd #x1B[2m2026-08-30T22:11:15.937065Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700786913282)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700774330369), 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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024700786913282)), timestamp: 1788127875, clock: EventClock(1 => 882024699779878914, 99 => 882024700774330369), 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:57931 (127.0.0.1:57931) 1788127875.940 sable_ircd #x1B[2m2026-08-30T22:11:15.940031Z#x1B[0m #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(882024700786913282)), timestamp: 1788127875, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }) 1788127875.940 sable_ircd #x1B[2m2026-08-30T22:11:15.940062Z#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(882024700786913282)), timestamp: 1788127875, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] } 1788127875.940 sable_ircd #x1B[2m2026-08-30T22:11:15.940145Z#x1B[0m #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(882024700786913282)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127875.940 sable_ircd #x1B[2m2026-08-30T22:11:15.940165Z#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(882024700786913282)), timestamp: 1788127875, change: EventComplete(EventComplete), users_to_notify: [] } 1788127875.978 sable_ircd #x1B[2m2026-08-30T22:11:15.977705Z#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), 1788127875), 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: [] 1788127876.191 sable_ircd #x1B[2m2026-08-30T22:11:16.191427Z#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 1788127876.192 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 1788127876.509 sable_history #x1B[2m2027-08-30T23:27:51.009586Z#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(1014315545035743318)), timestamp: 1819668471, clock: EventClock(1 => 1014295401760559126, 50 => 1014315293377503317, 99 => 1014295404927660036), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819668471 }) }; event clock=EventClock(1 => 1014295401760559126, 50 => 1014315293377503317, 99 => 1014295404927660036) my clock=EventClock(1 => 1014295401760559126, 50 => 1014315293377503317, 99 => 1014295404927660036) 1788127876.509 sable_history #x1B[2m2027-08-30T23:27:51.011037Z#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 1788127876.899 sable_history #x1B[2m2027-08-30T23:17:35.383005Z#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(1014312962913149003)), timestamp: 1819667855, clock: EventClock(1 => 1014295842380582945, 50 => 1014312711254909002, 99 => 1014295842997547013), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667855 }) }; event clock=EventClock(1 => 1014295842380582945, 50 => 1014312711254909002, 99 => 1014295842997547013) my clock=EventClock(1 => 1014295842380582945, 50 => 1014312711254909002, 99 => 1014295842997547013) 1788127876.899 sable_history #x1B[2m2027-08-30T23:17:35.384570Z#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 1788127877.126 sable_history #x1B[2m2027-08-30T23:30:40.339683Z#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(1014316255257239641)), timestamp: 1819668640, clock: EventClock(1 => 1014295353727389718, 50 => 1014316003603193944, 99 => 1014295356898684932), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819668640 }) }; event clock=EventClock(1 => 1014295353727389718, 50 => 1014316003603193944, 99 => 1014295356898684932) my clock=EventClock(1 => 1014295353727389718, 50 => 1014316003603193944, 99 => 1014295356898684932) 1788127877.126 sable_history #x1B[2m2027-08-30T23:30:40.341130Z#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 1788127877.137 sable_history #x1B[2m2027-08-30T23:14:47.716069Z#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(1014312259666780231)), timestamp: 1819667687, clock: EventClock(1 => 1014295135892017153, 50 => 1014312008008540230), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667687 }) }; event clock=EventClock(1 => 1014295135892017153, 50 => 1014312008008540230) my clock=EventClock(1 => 1014295135892017153, 50 => 1014312008008540230) 1788127877.137 sable_history #x1B[2m2027-08-30T23:14:47.717551Z#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 1788127877.193 chkSvs: waiting… 1788127877.197 sable_ircd #x1B[2m2026-08-30T22:11:17.196755Z#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 :synchronize521.97599786 1788127877.197 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize521.97599786 1788127877.197 chkSvs -> S: QUIT 1788127877.197 chkSvs -> S: PING synchronize523.318854795 1788127877.197 sable_ircd #x1B[2m2026-08-30T22:11:17.197414Z#x1B[0m #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 1788127877.197 sable_ircd #x1B[2m2026-08-30T22:11:17.197450Z#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" 1788127877.198 sable_ircd #x1B[2m2026-08-30T22:11:17.197495Z#x1B[0m #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 1788127877.198 sable_ircd #x1B[2m2026-08-30T22:11:17.197510Z#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 synchronize523.318854795" 1788127877.637 sable_history #x1B[2m2027-08-30T23:33:46.047699Z#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(1014317034177241180)), timestamp: 1819668826, clock: EventClock(1 => 1014295552021499922, 50 => 1014316782519001179, 99 => 1014295555868078086), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819668826 }) }; event clock=EventClock(1 => 1014295552021499922, 50 => 1014316782519001179, 99 => 1014295555868078086) my clock=EventClock(1 => 1014295552021499922, 50 => 1014316782519001179, 99 => 1014295555868078086) 1788127877.637 sable_history #x1B[2m2027-08-30T23:33:46.049115Z#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 1788127877.756 sable_history #x1B[2m2027-08-30T23:14:48.191911Z#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(1014312261663268935)), timestamp: 1819667688, clock: EventClock(1 => 1014295138538622977, 50 => 1014312009996640326), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667688 }) }; event clock=EventClock(1 => 1014295138538622977, 50 => 1014312009996640326) my clock=EventClock(1 => 1014295138538622977, 50 => 1014312009996640326) 1788127877.756 sable_history #x1B[2m2027-08-30T23:14:48.193651Z#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 1788127877.964 sable_history #x1B[2m2027-08-30T23:20:24.671514Z#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(1014313672958484558)), timestamp: 1819668024, clock: EventClock(1 => 1014295541992919062, 50 => 1014313421300244557, 99 => 1014295545160019972), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819668024 }) }; event clock=EventClock(1 => 1014295541992919062, 50 => 1014313421300244557, 99 => 1014295545160019972) my clock=EventClock(1 => 1014295541992919062, 50 => 1014313421300244557, 99 => 1014295545160019972) 1788127877.964 sable_history #x1B[2m2027-08-30T23:20:24.673152Z#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 1788127878.198 chkSvs: waiting… 1788127878.203 sable_ircd #x1B[2m2026-08-30T22:11:18.202637Z#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 1788127878.203 sable_ircd #x1B[2m2026-08-30T22:11:18.202781Z#x1B[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)) 1788127878.203 sable_ircd #x1B[2m2026-08-30T22:11:18.202804Z#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) 1788127878.203 sable_ircd #x1B[2m2026-08-30T22:11:18.202909Z#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(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 882024699779878914, 99 => 882024700786913282) my clock=EventClock(1 => 882024699779878914, 99 => 882024700786913282) 1788127878.203 S -> chkSvs: ERROR :Client quit 1788127878.203 chkSvs: disconnects from server. 1788127878.204 sable_ircd #x1B[2m2026-08-30T22:11:18.203171Z#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 1788127878.204 sable_ircd #x1B[2m2026-08-30T22:11:18.203236Z#x1B[0m #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 1788127878.204 sable_ircd #x1B[2m2026-08-30T22:11:18.203324Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), 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:57931 (127.0.0.1:57931) 1788127878.204 1: connects to server. 1788127878.204 1 -> S: NICK foo 1788127878.204 1 -> S: USER r e g :user 1788127878.204 sable_ircd #x1B[2m2026-08-30T22:11:18.204119Z#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 } 1788127878.204 sable_ircd #x1B[2m2026-08-30T22:11:18.204188Z#x1B[0m #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 1788127878.204 sable_ircd #x1B[2m2026-08-30T22:11:18.204211Z#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 1788127878.204 sable_ircd #x1B[2m2026-08-30T22:11:18.204250Z#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 1788127878.204 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127878.205 sable_ircd #x1B[2m2026-08-30T22:11:18.204644Z#x1B[0m #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 1788127878.205 sable_ircd #x1B[2m2026-08-30T22:11:18.204683Z#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" 1788127878.205 sable_ircd #x1B[2m2026-08-30T22:11:18.204870Z#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: 524, tv_nsec: 325857644 }, 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 1788127878.205 sable_ircd #x1B[2m2026-08-30T22:11:18.204920Z#x1B[0m #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 1788127878.205 sable_ircd #x1B[2m2026-08-30T22:11:18.204945Z#x1B[0m #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 1788127878.205 sable_ircd #x1B[2m2026-08-30T22:11:18.204972Z#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" 1788127878.205 sable_ircd #x1B[2m2026-08-30T22:11:18.205196Z#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: 524, tv_nsec: 325857644 }, 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 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.205486Z#x1B[0m #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 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.205515Z#x1B[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")) 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.205540Z#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 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.205559Z#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: 524, tv_nsec: 325857644 }, 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 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.205596Z#x1B[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)) 1788127878.206 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.206029Z#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(882024710483742724)), timestamp: 1788127878, clock: EventClock(1 => 882024710466965507, 99 => 882024700786913282), target: User(UserId(Snowflake(882024699779878912))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 882024710466965507, 99 => 882024700786913282) my clock=EventClock(1 => 882024710466965507, 99 => 882024700786913282) 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.206310Z#x1B[0m #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(882024710466965507)), timestamp: 1788127878, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(882024699779878912)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(882024699779878913)), user: UserId(Snowflake(882024699779878912)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127875 } }), users_to_notify: [] }) 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.206350Z#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(882024710466965507)), timestamp: 1788127878, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(882024699779878912)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(882024699779878913)), user: UserId(Snowflake(882024699779878912)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127875 } }), users_to_notify: [] } 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.206419Z#x1B[0m #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(882024710466965507)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127878.206 sable_ircd #x1B[2m2026-08-30T22:11:18.206441Z#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(882024710466965507)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] } 1788127878.207 sable_ircd #x1B[2m2026-08-30T22:11:18.206535Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710483742724)), timestamp: 1788127878, clock: EventClock(1 => 882024710466965507, 99 => 882024700786913282), target: User(UserId(Snowflake(882024699779878912))), 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:57931 (127.0.0.1:57931) 1788127878.209 sable_ircd #x1B[2m2026-08-30T22:11:18.209247Z#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(882024710496325637)), timestamp: 1788127878, clock: EventClock(1 => 882024710483742724, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), 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(882024710479548419)), NewUserConnection { user: UserId(Snowflake(882024710479548418)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127878 })) }) }; event clock=EventClock(1 => 882024710483742724, 99 => 882024700786913282) my clock=EventClock(1 => 882024710483742724, 99 => 882024700786913282) 1788127878.210 sable_ircd #x1B[2m2026-08-30T22:11:18.209483Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710496325637)), timestamp: 1788127878, clock: EventClock(1 => 882024710483742724, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), 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(882024710479548419)), NewUserConnection { user: UserId(Snowflake(882024710479548418)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127878 })) }) }) } #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:57931 (127.0.0.1:57931) 1788127878.210 sable_ircd #x1B[2m2026-08-30T22:11:18.209617Z#x1B[0m #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(882024710483742724)), timestamp: 1788127878, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(882024699779878912)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1788127878.210 sable_ircd #x1B[2m2026-08-30T22:11:18.209643Z#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(882024710483742724)), timestamp: 1788127878, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(882024699779878912)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1788127878.210 sable_ircd #x1B[2m2026-08-30T22:11:18.209684Z#x1B[0m #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(882024710483742724)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127878.210 sable_ircd #x1B[2m2026-08-30T22:11:18.209700Z#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(882024710483742724)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] } 1788127878.210 sable_services #x1B[2m2026-08-30T22:11:18.210046Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710483742724)), timestamp: 1788127878, clock: EventClock(1 => 882024710466965507, 99 => 882024700786913282), target: User(UserId(Snowflake(882024699779878912))), 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(882024710483742724)), timestamp: 1788127878, clock: EventClock(1 => 882024710466965507, 99 => 882024700786913282), target: User(UserId(Snowflake(882024699779878912))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 882024710466965507, 99 => 882024700786913282) my clock=EventClock(1 => 882024699779878914, 99 => 882024700786913282) 1788127878.210 sable_services #x1B[2m2026-08-30T22:11:18.210098Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710483742724)), timestamp: 1788127878, clock: EventClock(1 => 882024710466965507, 99 => 882024700786913282), target: User(UserId(Snowflake(882024699779878912))), 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(882024710466965507))] 1788127878.211 sable_services #x1B[2m2026-08-30T22:11:18.210339Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710483742724)), timestamp: 1788127878, clock: EventClock(1 => 882024710466965507, 99 => 882024700786913282), target: User(UserId(Snowflake(882024699779878912))), 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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710483742724)), timestamp: 1788127878, clock: EventClock(1 => 882024710466965507, 99 => 882024700786913282), target: User(UserId(Snowflake(882024699779878912))), 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:42123 (127.0.0.1:42123) 1788127878.211 sable_ircd #x1B[2m2026-08-30T22:11:18.211126Z#x1B[0m #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(882024710496325637)), timestamp: 1788127878, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 1) }), users_to_notify: [] }) 1788127878.211 sable_ircd #x1B[2m2026-08-30T22:11:18.211185Z#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(882024710496325637)), timestamp: 1788127878, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 1) }), users_to_notify: [] } 1788127878.211 sable_ircd #x1B[2m2026-08-30T22:11:18.211249Z#x1B[0m #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(882024710496325637)), timestamp: 1788127878, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 2), connection: UserConnectionId(Snowflake(882024710479548419)) }), users_to_notify: [] }) 1788127878.211 sable_ircd #x1B[2m2026-08-30T22:11:18.211297Z#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(882024710496325637)), timestamp: 1788127878, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 2), connection: UserConnectionId(Snowflake(882024710479548419)) }), users_to_notify: [] } 1788127878.211 sable_ircd #x1B[2m2026-08-30T22:11:18.211370Z#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 1788127878.211 sable_ircd #x1B[2m2026-08-30T22:11:18.211420Z#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 1788127878.211 sable_ircd #x1B[2m2026-08-30T22:11:18.211443Z#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-08-30 22:11:18.211433793 UTC 1788127878.211 sable_ircd #x1B[2m2026-08-30T22:11:18.211465Z#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 1788127878.212 sable_ircd #x1B[2m2026-08-30T22:11:18.211487Z#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 1788127878.212 sable_ircd #x1B[2m2026-08-30T22:11:18.211516Z#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 1788127878.212 sable_ircd #x1B[2m2026-08-30T22:11:18.211538Z#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 + 1788127878.212 sable_ircd #x1B[2m2026-08-30T22:11:18.211557Z#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. 1788127878.212 sable_ircd #x1B[2m2026-08-30T22:11:18.211607Z#x1B[0m #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(882024710496325637)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127878.212 sable_ircd #x1B[2m2026-08-30T22:11:18.211631Z#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(882024710496325637)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] } 1788127878.212 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo 1788127878.212 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127878.212 S -> 1: :My.Little.Server 003 foo :This server was created 2026-08-30 22:11:18.211433793 UTC 1788127878.212 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127878.212 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 1788127878.212 S -> 1: :My.Little.Server 422 foo :MOTD File is missing 1788127878.212 S -> 1: :foo!r@localhost MODE foo + 1788127878.212 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127878.247 sable_services #x1B[2m2026-08-30T22:11:18.246722Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), 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(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 882024699779878914, 99 => 882024700786913282) my clock=EventClock(1 => 882024699779878914, 99 => 882024700786913282) 1788127878.247 sable_services #x1B[2m2026-08-30T22:11:18.246788Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), 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(882024710483742724)), timestamp: 1788127878, clock: EventClock(1 => 882024710466965507, 99 => 882024700786913282), target: User(UserId(Snowflake(882024699779878912))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1788127878.247 sable_services #x1B[2m2026-08-30T22:11:18.247003Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), 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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), 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:42123 (127.0.0.1:42123) 1788127878.251 sable_ircd #x1B[2m2026-08-30T22:11:18.250543Z#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), 1788127875), content: GetEvent([EventId(Snowflake(882024710466965507))]) } }#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(882024710466965507))] 1788127878.251 sable_ircd #x1B[2m2026-08-30T22:11:18.250579Z#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), 1788127875), content: GetEvent([EventId(Snowflake(882024710466965507))]) } }#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(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), details: UserDisconnect(UserDisconnect) }] 1788127878.252 sable_services #x1B[2m2026-08-30T22:11:18.251590Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710496325637)), timestamp: 1788127878, clock: EventClock(1 => 882024710483742724, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), 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(882024710479548419)), NewUserConnection { user: UserId(Snowflake(882024710479548418)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127878 })) }) }) } }#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(882024710496325637)), timestamp: 1788127878, clock: EventClock(1 => 882024710483742724, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), 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(882024710479548419)), NewUserConnection { user: UserId(Snowflake(882024710479548418)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127878 })) }) }; event clock=EventClock(1 => 882024710483742724, 99 => 882024700786913282) my clock=EventClock(1 => 882024710483742724, 99 => 882024700786913282) 1788127878.252 sable_services #x1B[2m2026-08-30T22:11:18.251793Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710496325637)), timestamp: 1788127878, clock: EventClock(1 => 882024710483742724, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), 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(882024710479548419)), NewUserConnection { user: UserId(Snowflake(882024710479548418)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127878 })) }) }) } }#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024710496325637)), timestamp: 1788127878, clock: EventClock(1 => 882024710483742724, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), 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(882024710479548419)), NewUserConnection { user: UserId(Snowflake(882024710479548418)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127878 })) }) }) } #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:42123 (127.0.0.1:42123) 1788127878.292 sable_services #x1B[2m2026-08-30T22:11:18.291680Z#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), 1788127875), content: BulkEvents([Event { id: EventId(Snowflake(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), 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(882024710466965507)), timestamp: 1788127878, clock: EventClock(1 => 882024699779878914, 99 => 882024700786913282), target: UserConnection(UserConnectionId(Snowflake(882024699779878913))), details: UserDisconnect(UserDisconnect) }] 1788127878.312 1 -> S: PING synchronize524.433763006 1788127878.313 sable_ircd #x1B[2m2026-08-30T22:11:18.312777Z#x1B[0m #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 1788127878.313 sable_ircd #x1B[2m2026-08-30T22:11:18.312835Z#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 synchronize524.433763006" 1788127878.313 sable_ircd #x1B[2m2026-08-30T22:11:18.313073Z#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 :synchronize524.433763006 1788127878.314 sable_history #x1B[2m2027-08-30T23:14:48.949064Z#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(1014312264834162759)), timestamp: 1819667688, clock: EventClock(1 => 1014295140782575617, 50 => 1014312013150756934), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667688 }) }; event clock=EventClock(1 => 1014295140782575617, 50 => 1014312013150756934) my clock=EventClock(1 => 1014295140782575617, 50 => 1014312013150756934) 1788127878.314 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize524.433763006 1788127878.314 sable_history #x1B[2m2027-08-30T23:14:48.951438Z#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 1788127878.314 1 -> S: REGISTER * * éééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééé 1788127878.315 sable_ircd #x1B[2m2026-08-30T22:11:18.314491Z#x1B[0m #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 1788127878.315 sable_ircd #x1B[2m2026-08-30T22:11:18.314521Z#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 * * éééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééé" 1788127878.315 sable_ircd #x1B[2m2026-08-30T22:11:18.314707Z#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:57931", fingerprint: "20c44ff0776cf209469bc4785d9e1d2c92b92c5b" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("foo"), "éééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééé")) } 1788127878.315 sable_ircd #x1B[2m2026-08-30T22:11:18.314978Z#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), 1788127875), 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:57931 (127.0.0.1:57931) 1788127878.317 sable_ircd #x1B[2m2026-08-30T22:11:18.317182Z#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) }) 1788127878.358 sable_services #x1B[2m2026-08-30T22:11:18.358096Z#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"), "éééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééééé")) 1788127878.358 sable_services #x1B[2m2026-08-30T22:11:18.358142Z#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") 1788127878.362 sable_services #x1B[2m2026-08-30T22:11:18.362352Z#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(882024711121678336)), name: Nickname("foo"), authorised_fingerprints: [] } 1788127878.363 sable_services #x1B[2m2026-08-30T22:11:18.362511Z#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(882024711138455555)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: Account(AccountId(Snowflake(882024711121678336))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024711121678336)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 882024710496325637, 99 => 882024700786913282) my clock=EventClock(1 => 882024710496325637, 99 => 882024700786913282) 1788127878.363 sable_services #x1B[2m2026-08-30T22:11:18.362836Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024711138455555)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: Account(AccountId(Snowflake(882024711121678336))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024711121678336)), 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:42123 (127.0.0.1:42123) 1788127878.404 sable_ircd #x1B[2m2026-08-30T22:11:18.403749Z#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), 1788127875), content: TargetedMessageResponse(Services(LogUserIn(AccountId(Snowflake(882024711121678336))))) } } 1788127878.404 sable_ircd #x1B[2m2026-08-30T22:11:18.403975Z#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 1788127878.404 sable_ircd #x1B[2m2026-08-30T22:11:18.404026Z#x1B[0m #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 1788127878.404 sable_ircd #x1B[2m2026-08-30T22:11:18.404052Z#x1B[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(882024710479548418))), UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024711121678336))) })) 1788127878.404 sable_ircd #x1B[2m2026-08-30T22:11:18.404155Z#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(882024711314214918)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024711121678336))) }) }; event clock=EventClock(1 => 882024710496325637, 99 => 882024700786913282) my clock=EventClock(1 => 882024710496325637, 99 => 882024700786913282) 1788127878.405 sable_ircd #x1B[2m2026-08-30T22:11:18.404469Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024711314214918)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024711121678336))) }) }) } #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:57931 (127.0.0.1:57931) 1788127878.406 sable_ircd #x1B[2m2026-08-30T22:11:18.405999Z#x1B[0m #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(882024711314214918)), timestamp: 1788127878, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 3), old_account: None, new_account: Some(AccountId(Snowflake(882024711121678336))) }), users_to_notify: [] }) 1788127878.406 sable_ircd #x1B[2m2026-08-30T22:11:18.406040Z#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(882024711314214918)), timestamp: 1788127878, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 3), old_account: None, new_account: Some(AccountId(Snowflake(882024711121678336))) }), users_to_notify: [] } 1788127878.406 sable_ircd #x1B[2m2026-08-30T22:11:18.406076Z#x1B[0m #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(882024711314214918)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127878.406 sable_ircd #x1B[2m2026-08-30T22:11:18.406091Z#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(882024711314214918)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] } 1788127878.406 sable_ircd #x1B[2m2026-08-30T22:11:18.406110Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024711138455555)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: Account(AccountId(Snowflake(882024711121678336))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024711121678336)), 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(882024711138455555)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: Account(AccountId(Snowflake(882024711121678336))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024711121678336)), name: Nickname("foo"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 882024710496325637, 99 => 882024700786913282) my clock=EventClock(1 => 882024711314214918, 99 => 882024700786913282) 1788127878.406 sable_ircd #x1B[2m2026-08-30T22:11:18.406311Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024711138455555)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: Account(AccountId(Snowflake(882024711121678336))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024711121678336)), 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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024711138455555)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: Account(AccountId(Snowflake(882024711121678336))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(882024711121678336)), 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:57931 (127.0.0.1:57931) 1788127878.408 sable_ircd #x1B[2m2026-08-30T22:11:18.407630Z#x1B[0m #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(882024711138455555)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127878.408 sable_ircd #x1B[2m2026-08-30T22:11:18.407658Z#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(882024711138455555)), timestamp: 1788127878, change: EventComplete(EventComplete), users_to_notify: [] } 1788127878.447 sable_services #x1B[2m2026-08-30T22:11:18.446787Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024711314214918)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024711121678336))) }) }) } }#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(882024711314214918)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024711121678336))) }) }; event clock=EventClock(1 => 882024710496325637, 99 => 882024700786913282) my clock=EventClock(1 => 882024710496325637, 99 => 882024711138455555) 1788127878.447 sable_services #x1B[2m2026-08-30T22:11:18.447065Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024711314214918)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024711121678336))) }) }) } }#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024711314214918)), timestamp: 1788127878, clock: EventClock(1 => 882024710496325637, 99 => 882024700786913282), target: User(UserId(Snowflake(882024710479548418))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(882024711121678336))) }) }) } #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:42123 (127.0.0.1:42123) 1788127878.514 1 -> S: PING synchronize524.635817542 1788127878.514 S -> 1: REGISTER SUCCESS foo :You have successfully registered 1788127878.515 sable_ircd #x1B[2m2026-08-30T22:11:18.514726Z#x1B[0m #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 1788127878.515 sable_ircd #x1B[2m2026-08-30T22:11:18.514777Z#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 synchronize524.635817542" 1788127878.700 sable_history #x1B[2m2027-08-30T23:23:14.293812Z#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(1014314384408911953)), timestamp: 1819668194, clock: EventClock(1 => 1014295494442094614, 50 => 1014314132750671952, 99 => 1014295497634361348), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819668194 }) }; event clock=EventClock(1 => 1014295494442094614, 50 => 1014314132750671952, 99 => 1014295497634361348) my clock=EventClock(1 => 1014295494442094614, 50 => 1014314132750671952, 99 => 1014295497634361348) 1788127878.700 sable_history #x1B[2m2027-08-30T23:23:14.295316Z#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 1788127878.746 sable_history #x1B[2m2027-08-30T23:14:49.167813Z#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(1014312265756909639)), timestamp: 1819667689, clock: EventClock(1 => 1014295142766481409, 50 => 1014312014094475334), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667689 }) }; event clock=EventClock(1 => 1014295142766481409, 50 => 1014312014094475334) my clock=EventClock(1 => 1014295142766481409, 50 => 1014312014094475334) 1788127878.746 sable_history #x1B[2m2027-08-30T23:14:49.169242Z#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 1788127879.017 sable_ircd #x1B[2m2026-08-30T22:11:19.016900Z#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 :synchronize524.635817542 1788127879.017 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize524.635817542 1788127879.017 1 -> S: QUIT 1788127879.018 sable_ircd #x1B[2m2026-08-30T22:11:19.017511Z#x1B[0m #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 1788127879.018 sable_ircd #x1B[2m2026-08-30T22:11:19.017544Z#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" 1788127879.117 1 -> S: PING synchronize525.239044313 1788127879.118 sable_ircd #x1B[2m2026-08-30T22:11:19.117888Z#x1B[0m #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 1788127879.118 sable_ircd #x1B[2m2026-08-30T22:11:19.117945Z#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 synchronize525.239044313" 1788127879.128 sable_history #x1B[2m2027-08-30T23:14:49.548115Z#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(1014312267350745159)), timestamp: 1819667689, clock: EventClock(1 => 1014295144268042241, 50 => 1014312015688310854), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667689 }) }; event clock=EventClock(1 => 1014295144268042241, 50 => 1014312015688310854) my clock=EventClock(1 => 1014295144268042241, 50 => 1014312015688310854) 1788127879.128 sable_history #x1B[2m2027-08-30T23:14:49.549753Z#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 1788127879.632 sable_history #x1B[2m2027-08-30T23:26:02.100725Z#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(1014315088238288980)), timestamp: 1819668362, clock: EventClock(1 => 1014295448346693654, 50 => 1014314836580048979, 99 => 1014295451547348996), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819668362 }) }; event clock=EventClock(1 => 1014295448346693654, 50 => 1014314836580048979, 99 => 1014295451547348996) my clock=EventClock(1 => 1014295448346693654, 50 => 1014314836580048979, 99 => 1014295451547348996) 1788127879.632 sable_history #x1B[2m2027-08-30T23:26:02.102133Z#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 1788127879.649 sable_history #x1B[2m2027-08-30T23:14:50.148157Z#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(1014312269867327560)), timestamp: 1819667690, clock: EventClock(1 => 1014295224354082831, 50 => 1014312018209087559, 99 => 1014295214413983748), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819667690 }) }; event clock=EventClock(1 => 1014295224354082831, 50 => 1014312018209087559, 99 => 1014295214413983748) my clock=EventClock(1 => 1014295224354082831, 50 => 1014312018209087559, 99 => 1014295214413983748) 1788127879.649 sable_history #x1B[2m2027-08-30T23:14:50.149212Z#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 1788127880.119 1: waiting… 1788127880.123 sable_ircd #x1B[2m2026-08-30T22:11:20.123201Z#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 1788127880.123 sable_ircd #x1B[2m2026-08-30T22:11:20.123329Z#x1B[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)) 1788127880.123 sable_ircd #x1B[2m2026-08-30T22:11:20.123355Z#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) 1788127880.124 sable_ircd #x1B[2m2026-08-30T22:11:20.123513Z#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(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 882024711314214918, 99 => 882024711138455555) my clock=EventClock(1 => 882024711314214918, 99 => 882024711138455555) 1788127880.124 S -> 1: ERROR :Client quit 1788127880.124 sable_ircd #x1B[2m2026-08-30T22:11:20.123792Z#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 1788127880.124 sable_ircd #x1B[2m2026-08-30T22:11:20.123848Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), 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:57931 (127.0.0.1:57931) 1788127880.124 sable_ircd #x1B[2m2026-08-30T22:11:20.123858Z#x1B[0m #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 1788127880.125 sable_ircd #x1B[2m2026-08-30T22:11:20.125322Z#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(882024718532612104)), timestamp: 1788127880, clock: EventClock(1 => 882024718524223495, 99 => 882024711138455555), target: User(UserId(Snowflake(882024710479548418))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 882024718524223495, 99 => 882024711138455555) my clock=EventClock(1 => 882024718524223495, 99 => 882024711138455555) 1788127880.126 sable_ircd #x1B[2m2026-08-30T22:11:20.125564Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718532612104)), timestamp: 1788127880, clock: EventClock(1 => 882024718524223495, 99 => 882024711138455555), target: User(UserId(Snowflake(882024710479548418))), 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:57931 (127.0.0.1:57931) 1788127880.126 sable_ircd #x1B[2m2026-08-30T22:11:20.125705Z#x1B[0m #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(882024718524223495)), timestamp: 1788127880, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(882024710479548419)), user: UserId(Snowflake(882024710479548418)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127878 } }), users_to_notify: [] }) 1788127880.126 sable_ircd #x1B[2m2026-08-30T22:11:20.125764Z#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(882024718524223495)), timestamp: 1788127880, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(882024710479548419)), user: UserId(Snowflake(882024710479548418)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127878 } }), users_to_notify: [] } 1788127880.126 sable_ircd #x1B[2m2026-08-30T22:11:20.125836Z#x1B[0m #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(882024718524223495)), timestamp: 1788127880, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127880.126 sable_ircd #x1B[2m2026-08-30T22:11:20.125883Z#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(882024718524223495)), timestamp: 1788127880, change: EventComplete(EventComplete), users_to_notify: [] } 1788127880.129 sable_ircd #x1B[2m2026-08-30T22:11:20.128534Z#x1B[0m #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(882024718532612104)), timestamp: 1788127880, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 3), nickname: Nickname("foo"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1788127880.129 sable_ircd #x1B[2m2026-08-30T22:11:20.128570Z#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(882024718532612104)), timestamp: 1788127880, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(882024710479548418)), 3), nickname: Nickname("foo"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1788127880.129 sable_ircd #x1B[2m2026-08-30T22:11:20.128618Z#x1B[0m #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(882024718532612104)), timestamp: 1788127880, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127880.129 sable_ircd #x1B[2m2026-08-30T22:11:20.128636Z#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(882024718532612104)), timestamp: 1788127880, change: EventComplete(EventComplete), users_to_notify: [] } 1788127880.129 sable_services #x1B[2m2026-08-30T22:11:20.129163Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718532612104)), timestamp: 1788127880, clock: EventClock(1 => 882024718524223495, 99 => 882024711138455555), target: User(UserId(Snowflake(882024710479548418))), 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(882024718532612104)), timestamp: 1788127880, clock: EventClock(1 => 882024718524223495, 99 => 882024711138455555), target: User(UserId(Snowflake(882024710479548418))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 882024718524223495, 99 => 882024711138455555) my clock=EventClock(1 => 882024711314214918, 99 => 882024711138455555) 1788127880.129 sable_services #x1B[2m2026-08-30T22:11:20.129210Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718532612104)), timestamp: 1788127880, clock: EventClock(1 => 882024718524223495, 99 => 882024711138455555), target: User(UserId(Snowflake(882024710479548418))), 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(882024718524223495))] 1788127880.130 sable_services #x1B[2m2026-08-30T22:11:20.129458Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718532612104)), timestamp: 1788127880, clock: EventClock(1 => 882024718524223495, 99 => 882024711138455555), target: User(UserId(Snowflake(882024710479548418))), 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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718532612104)), timestamp: 1788127880, clock: EventClock(1 => 882024718524223495, 99 => 882024711138455555), target: User(UserId(Snowflake(882024710479548418))), 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:42123 (127.0.0.1:42123) 1788127880.167 sable_services #x1B[2m2026-08-30T22:11:20.166689Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), 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(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 882024711314214918, 99 => 882024711138455555) my clock=EventClock(1 => 882024711314214918, 99 => 882024711138455555) 1788127880.167 sable_services #x1B[2m2026-08-30T22:11:20.166747Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), 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(882024718532612104)), timestamp: 1788127880, clock: EventClock(1 => 882024718524223495, 99 => 882024711138455555), target: User(UserId(Snowflake(882024710479548418))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1788127880.167 sable_services #x1B[2m2026-08-30T22:11:20.166955Z#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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), 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), 1788127875), content: NewEvent(Event { id: EventId(Snowflake(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), 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:42123 (127.0.0.1:42123) 1788127880.171 sable_ircd #x1B[2m2026-08-30T22:11:20.170538Z#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), 1788127875), content: GetEvent([EventId(Snowflake(882024718524223495))]) } }#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(882024718524223495))] 1788127880.171 sable_ircd #x1B[2m2026-08-30T22:11:20.170576Z#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), 1788127875), content: GetEvent([EventId(Snowflake(882024718524223495))]) } }#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(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), details: UserDisconnect(UserDisconnect) }] 1788127880.212 sable_services #x1B[2m2026-08-30T22:11:20.211636Z#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), 1788127875), content: BulkEvents([Event { id: EventId(Snowflake(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), 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(882024718524223495)), timestamp: 1788127880, clock: EventClock(1 => 882024711314214918, 99 => 882024711138455555), target: UserConnection(UserConnectionId(Snowflake(882024710479548419))), details: UserDisconnect(UserDisconnect) }] 1788127880.224 1 -> S: PING synchronize526.345413747 1788127880.224 1: connects to server. 1788127880.224 1 -> S: CAP REQ :sasl 1788127880.225 sable_ircd #x1B[2m2026-08-30T22:11:20.224628Z#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 } 1788127880.225 sable_ircd #x1B[2m2026-08-30T22:11:20.224733Z#x1B[0m #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 1788127880.225 sable_ircd #x1B[2m2026-08-30T22:11:20.224762Z#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 1788127880.225 sable_ircd #x1B[2m2026-08-30T22:11:20.224807Z#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 1788127880.225 sable_ircd #x1B[2m2026-08-30T22:11:20.224916Z#x1B[0m #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 1788127880.225 sable_ircd #x1B[2m2026-08-30T22:11:20.224949Z#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" 1788127880.225 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127880.225 sable_ircd #x1B[2m2026-08-30T22:11:20.225071Z#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 1788127880.225 sable_ircd #x1B[2m2026-08-30T22:11:20.225113Z#x1B[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)) 1788127880.225 S -> 1: :My.Little.Server CAP * ACK :sasl 1788127880.225 1 -> S: AUTHENTICATE PLAIN 1788127880.226 sable_ircd #x1B[2m2026-08-30T22:11:20.225613Z#x1B[0m #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 1788127880.226 sable_ircd #x1B[2m2026-08-30T22:11:20.225652Z#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" 1788127880.226 sable_ircd #x1B[2m2026-08-30T22:11:20.225758Z#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(882024718952042500)) 1788127880.226 sable_ircd #x1B[2m2026-08-30T22:11:20.225868Z#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:57931", fingerprint: "20c44ff0776cf209469bc4785d9e1d2c92b92c5b" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(882024718952042500)), "PLAIN")) } 1788127880.226 sable_ircd #x1B[2m2026-08-30T22:11:20.225951Z#x1B[0m #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 1788127880.226 sable_ircd #x1B[2m2026-08-30T22:11:20.225978Z#x1B[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")) 1788127880.226 sable_ircd #x1B[2m2026-08-30T22:11:20.226010Z#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 1788127880.226 sable_ircd #x1B[2m2026-08-30T22:11:20.226033Z#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: 526, tv_nsec: 346409679 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: }, 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 1788127880.226 sable_ircd #x1B[2m2026-08-30T22:11:20.226055Z#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), 1788127875), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(882024718952042500)), "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:57931 (127.0.0.1:57931) 1788127880.226 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127880.227 sable_ircd #x1B[2m2026-08-30T22:11:20.227343Z#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) }) 1788127880.269 sable_services #x1B[2m2026-08-30T22:11:20.268773Z#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(882024718952042500)), "PLAIN")) 1788127880.269 sable_services #x1B[2m2026-08-30T22:11:20.268820Z#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(882024718952042500)) #x1B[3mmechanism#x1B[0m#x1B[2m=#x1B[0m"PLAIN" 1788127880.310 sable_ircd #x1B[2m2026-08-30T22:11:20.309687Z#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), 1788127875), content: TargetedMessageResponse(Services(Authenticate(InProgress([])))) } } 1788127880.310 sable_ircd #x1B[2m2026-08-30T22:11:20.309862Z#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 :+ 1788127880.310 sable_ircd #x1B[2m2026-08-30T22:11:20.309917Z#x1B[0m #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 1788127880.310 S -> 1: AUTHENTICATE :+ 1788127880.310 1 -> S: AUTHENTICATE Zm9vAGZvbwDDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqcOpw6nDqQ== 1788127880.311 sable_ircd #x1B[2m2026-08-30T22:11:20.310585Z#x1B[0m #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 1788127880.311 sable_ircd #x1B[2m2026-08-30T22:11:20.310622Z#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==" 1788127880.311 sable_ircd #x1B[2m2026-08-30T22:11:20.310750Z#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(882024718952042500)) 1788127880.311 sable_ircd #x1B[2m2026-08-30T22:11:20.310849Z#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:57931", fingerprint: "20c44ff0776cf209469bc4785d9e1d2c92b92c5b" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(Authenticate(SaslSessionId(Snowflake(882024718952042500)), [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])) } 1788127880.311 sable_ircd #x1B[2m2026-08-30T22:11:20.311054Z#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), 1788127875), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(Authenticate(SaslSessionId(Snowflake(882024718952042500)), [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:57931 (127.0.0.1:57931) 1788127880.312 sable_ircd #x1B[2m2026-08-30T22:11:20.312397Z#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) }) 1788127880.354 sable_services #x1B[2m2026-08-30T22:11:20.353770Z#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(882024718952042500)), [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])) 1788127880.354 sable_services #x1B[2m2026-08-30T22:11:20.353828Z#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(882024718952042500)) #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] 1788127880.357 sable_services #x1B[2m2026-08-30T22:11:20.357116Z#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") 1788127880.398 sable_ircd #x1B[2m2026-08-30T22:11:20.397674Z#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), 1788127875), content: TargetedMessageResponse(Services(Authenticate(Success(AccountId(Snowflake(882024711121678336)))))) } } 1788127880.398 sable_ircd #x1B[2m2026-08-30T22:11:20.397855Z#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 1788127880.398 sable_ircd #x1B[2m2026-08-30T22:11:20.397887Z#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 1788127880.398 sable_ircd #x1B[2m2026-08-30T22:11:20.397915Z#x1B[0m #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 1788127880.398 S -> 1: :My.Little.Server 900 * * foo :You are now logged in as foo 1788127880.400 sable_ircd #x1B[2m2026-08-30T22:11:20.400021Z#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 1788127880.400 sable_ircd #x1B[2m2026-08-30T22:11:20.400186Z#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 1788127880.400 sable_ircd #x1B[2m2026-08-30T22:11:20.400185Z#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:42123, peer: 127.0.0.1:51069, fd: 19 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x5633ea4ae010, 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 1788127880.400 sable_ircd #x1B[2m2026-08-30T22:11:20.400241Z#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 1788127880.405 1: disconnects from server.