--------------------------------- Captured Out --------------------------------- ---- new test ---- 1772747455.007 sable_services uid=1001 1772747455.008 sable_services #x1B[2m2027-03-05T21:50:55.084063Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.Server"), address: "127.0.0.1:51511", fingerprint: "24c02a0c9f607ed28cd8456d2eda56ff1765d729" } 1772747455.009 sable_services #x1B[2m2027-03-05T21:50:55.088352Z#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), 1804283455), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:51511. Last error: I/O error: Connection refused (os error 111) 1772747455.009 sable_services #x1B[2m2027-03-05T21:50:55.089153Z#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), 1804283455), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1772747455.010 sable_ircd uid=1001 1772747455.014 sable_services #x1B[2m2027-03-05T21:50:55.176788Z#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:59205", fingerprint: "8a7ed04f2d52090ebbcdda392b0cc9390d2dec55" } 1772747455.015 sable_services #x1B[2m2027-03-05T21:50:55.180021Z#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), 1804283455), 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:59205. Last error: I/O error: Connection refused (os error 111) 1772747455.015 sable_services #x1B[2m2027-03-05T21:50:55.180689Z#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), 1804283455), 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) 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.191080Z#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(949786111650041856)), timestamp: 1804283455, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Server"), ts: 1804283455, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.193213Z#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 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.197115Z#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(949786111650041856)), timestamp: 1804283455, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Server"), ts: 1804283455, 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 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.200514Z#x1B[0m #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(949786111650041856)), timestamp: 1804283455, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.201092Z#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(949786111650041856)), timestamp: 1804283455, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.201720Z#x1B[0m #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(949786111650041856)), timestamp: 1804283455, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.202044Z#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(949786111650041856)), timestamp: 1804283455, change: EventComplete(EventComplete), users_to_notify: [] } 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.212386Z#x1B[0m #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 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.217524Z#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(949786111763288065)), timestamp: 1804283455, clock: EventClock(1 => 949786111650041856), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283455 }) }; event clock=EventClock(1 => 949786111650041856) my clock=EventClock(1 => 949786111650041856) 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.218610Z#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 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.221808Z#x1B[0m #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(949786111763288065)), timestamp: 1804283455, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747455.017 sable_ircd #x1B[2m2027-03-05T21:50:55.222290Z#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(949786111763288065)), timestamp: 1804283455, change: EventComplete(EventComplete), users_to_notify: [] } 1772747455.026 sable_services #x1B[2m2027-03-05T21:50:55.348822Z#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:51511", fingerprint: "24c02a0c9f607ed28cd8456d2eda56ff1765d729" } (attempt #3). 1772747455.026 sable_services #x1B[2m2027-03-05T21:50:55.349534Z#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. 1772747455.026 sable_services #x1B[2m2027-03-05T21:50:55.353867Z#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), 1804283455), 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:51511 (127.0.0.1:51511) 1772747455.073 sable_ircd #x1B[2m2027-03-05T21:50:56.055054Z#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 1772747455.102 sable_ircd #x1B[2m2027-03-05T21:50:56.491422Z#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 } 1772747455.102 sable_ircd #x1B[2m2027-03-05T21:50:56.493047Z#x1B[0m #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 1772747455.102 sable_ircd #x1B[2m2027-03-05T21:50:56.494096Z#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 1772747455.102 sable_ircd #x1B[2m2027-03-05T21:50:56.495293Z#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 1772747455.103 sable_ircd #x1B[2m2027-03-05T21:50:56.499969Z#x1B[0m #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 1772747455.103 sable_ircd #x1B[2m2027-03-05T21:50:56.501251Z#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" 1772747455.103 sable_ircd #x1B[2m2027-03-05T21:50:56.503221Z#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 1772747455.103 sable_ircd #x1B[2m2027-03-05T21:50:56.504649Z#x1B[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)) 1772747455.103 sable_ircd #x1B[2m2027-03-05T21:50:56.505258Z#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) 1772747455.103 sable_ircd #x1B[2m2027-03-05T21:50:56.509705Z#x1B[0m #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 1772747455.103 sable_ircd #x1B[2m2027-03-05T21:50:56.511875Z#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 1772747455.103 sable_ircd #x1B[2m2027-03-05T21:50:56.513130Z#x1B[0m #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 1772747455.114 sable_services #x1B[2m2027-03-05T21:50:56.671938Z#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), 1804283455), content: NetworkState(Network { nick_bindings: {}, historic_nick_users: HistoricNickStore { data: {} }, users: {}, historic_users: HistoricUserStore { users: {} }, user_connections: {}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1804283455, name: ServerName("My.Little.Server"), last_ping: 1804283455, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }}, network_bans: BanRepository { pre_registration_bans: {}, new_connection_bans: {}, pre_sasl_bans: {}, pre_registration_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: ["", "", "", "", "", ""], uint64: [], regex: [] }, fields: {"user_param_2": (1, String(_)), "user": (0, String(_)), "ip": (0, Ip(_)), "nick": (3, String(_)), "tls": (0, Boolean(_)), "user_param_1": (5, String(_)), "realname": (4, String(_)), "host": (2, String(_))} }, new_connection_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [], uint64: [], regex: [] }, fields: {"ip": (0, Ip(_)), "tls": (0, Boolean(_))} }, pre_sasl_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [""], uint64: [], regex: [] }, fields: {"mechanism": (0, String(_)), "tls": (0, Boolean(_)), "ip": (0, Ip(_))} } }, audit_log: {}, accounts: {}, nick_registrations: {}, channel_registrations: {}, channel_accesses: {}, channel_roles: {}, current_services: None, current_history_server_id: None, config: NetworkConfig { opers: [OperConfig { name: "operuser", hash: "$6$z5yA.OfGliDoi/R2$BgSsguS6bxAsPSCygDisgDw5JZuo5.88eU3Hyc7/4OaNpeKIxWGjOggeHzOl0xLiZg1vfwxXjOTFN14wG5vNI." }], debug_mode: true, default_roles: {BuiltinVoice: ChannelAccessSet(4296081441), BuiltinOp: ChannelAccessSet(222192934775), BuiltinAll: ChannelAccessSet(1114112)}, alias_users: [AliasUser { nick: Nickname("ChanServ"), user: Username("ChanServ"), host: Hostname("services."), realname: Realname("Channel services compatibility layer"), command_alias: "CS" }, AliasUser { nick: Nickname("NickServ"), user: Username("NickServ"), host: Hostname("services."), realname: Realname("Account services compatibility layer"), command_alias: "NS" }], object_expiry: 60, pingout_duration: 600 }, clock: EventClock(1 => 949786111763288065), cache_default_channel_roles: OnceLock(), alias_users: OnceLock() }) } 1772747455.114 sable_services #x1B[2m2027-03-05T21:50:56.674415Z#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 1772747455.114 sable_services #x1B[2m2027-03-05T21:50:56.676346Z#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 1772747455.115 sable_services #x1B[2m2027-03-05T21:50:56.683837Z#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(949786117912539136)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Services"), ts: 1804283456, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 949786111763288065) my clock=EventClock(1 => 949786111763288065) 1772747455.115 sable_services #x1B[2m2027-03-05T21:50:56.689425Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786117912539136)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Services"), ts: 1804283456, 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:51511 (127.0.0.1:51511) 1772747455.117 sable_services #x1B[2m2027-03-05T21:50:56.717488Z#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(949786118055145473)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786117912539136), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283456 }) }; event clock=EventClock(1 => 949786111763288065, 99 => 949786117912539136) my clock=EventClock(1 => 949786111763288065, 99 => 949786117912539136) 1772747455.117 sable_services #x1B[2m2027-03-05T21:50:56.721477Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786118055145473)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786117912539136), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283456 }) }) } #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:51511 (127.0.0.1:51511) 1772747455.118 sable_services #x1B[2m2027-03-05T21:50:56.730347Z#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(949786117912539136)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Services"), ts: 1804283456, 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 1772747455.121 sable_services #x1B[2m2027-03-05T21:50:56.778913Z#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(949786118310998018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786118055145473), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 949786111763288065, 99 => 949786118055145473) my clock=EventClock(1 => 949786111763288065, 99 => 949786118055145473) 1772747455.122 sable_services #x1B[2m2027-03-05T21:50:56.783836Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786118310998018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786118055145473), 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:51511 (127.0.0.1:51511) 1772747455.122 sable_ircd #x1B[2m2027-03-05T21:50:56.797998Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786118055145473)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786117912539136), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283456 }) }) } }#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(949786118055145473)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786117912539136), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283456 }) }; event clock=EventClock(1 => 949786111763288065, 99 => 949786117912539136) my clock=EventClock(1 => 949786111763288065) 1772747455.122 sable_ircd #x1B[2m2027-03-05T21:50:56.799629Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786118055145473)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786117912539136), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283456 }) }) } }#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(949786117912539136))] 1772747455.123 sable_ircd #x1B[2m2027-03-05T21:50:56.800540Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786118055145473)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786117912539136), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283456 }) }) } }#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 1772747455.123 chkSvs: connects to server. 1772747455.124 chkSvs -> S: NICK chkSvs 1772747455.124 chkSvs -> S: USER chk chk chk chk 1772747455.124 sable_ircd #x1B[2m2027-03-05T21:50:56.829645Z#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 } 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.831602Z#x1B[0m #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 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.832237Z#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 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.833063Z#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 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.835445Z#x1B[0m #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 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.836204Z#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" 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.838747Z#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: 1804283456, tv_nsec: 832702014 }, 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 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.839661Z#x1B[0m #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 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.840165Z#x1B[0m #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 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.840620Z#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" 1772747455.125 sable_ircd #x1B[2m2027-03-05T21:50:56.841597Z#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: 1804283456, tv_nsec: 832702014 }, 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 1772747455.126 sable_ircd #x1B[2m2027-03-05T21:50:56.850105Z#x1B[0m #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 1772747455.126 sable_ircd #x1B[2m2027-03-05T21:50:56.850746Z#x1B[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")) 1772747455.126 sable_ircd #x1B[2m2027-03-05T21:50:56.851271Z#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 1772747455.126 sable_ircd #x1B[2m2027-03-05T21:50:56.851614Z#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: 1804283456, tv_nsec: 832702014 }, 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 1772747455.126 sable_ircd #x1B[2m2027-03-05T21:50:56.852245Z#x1B[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)) 1772747455.126 sable_ircd #x1B[2m2027-03-05T21:50:56.855724Z#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(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }; event clock=EventClock(1 => 949786111763288065) my clock=EventClock(1 => 949786111763288065) 1772747455.126 sable_ircd #x1B[2m2027-03-05T21:50:56.857225Z#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 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.861190Z#x1B[0m #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(949786118633558018)), timestamp: 1804283456, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(949786118625169408)), 1) }), users_to_notify: [] }) 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.861878Z#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(949786118633558018)), timestamp: 1804283456, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(949786118625169408)), 1) }), users_to_notify: [] } 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.863007Z#x1B[0m #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(949786118633558018)), timestamp: 1804283456, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(949786118625169408)), 2), connection: UserConnectionId(Snowflake(949786118625169409)) }), users_to_notify: [] }) 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.863553Z#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(949786118633558018)), timestamp: 1804283456, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(949786118625169408)), 2), connection: UserConnectionId(Snowflake(949786118625169409)) }), users_to_notify: [] } 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.864583Z#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 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.865250Z#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 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.866010Z#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 2027-03-05 21:50:56.865760649 UTC 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.866617Z#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 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.867541Z#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 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.868102Z#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 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.868775Z#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 + 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.869577Z#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. 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.870638Z#x1B[0m #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(949786118633558018)), timestamp: 1804283456, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747455.127 sable_ircd #x1B[2m2027-03-05T21:50:56.871156Z#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(949786118633558018)), timestamp: 1804283456, change: EventComplete(EventComplete), users_to_notify: [] } 1772747455.158 sable_ircd #x1B[2m2027-03-05T21:50:57.330808Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786117912539136)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Services"), ts: 1804283456, 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(949786117912539136)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Services"), ts: 1804283456, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 949786111763288065) my clock=EventClock(1 => 949786118633558018) 1772747455.158 sable_ircd #x1B[2m2027-03-05T21:50:57.332130Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786117912539136)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Services"), ts: 1804283456, 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(949786118055145473)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786117912539136), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283456 }) } 1772747455.158 sable_ircd #x1B[2m2027-03-05T21:50:57.333105Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786117912539136)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Services"), ts: 1804283456, 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 1772747455.158 sable_ircd #x1B[2m2027-03-05T21:50:57.337148Z#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(949786117912539136)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1804283455, name: ServerName("My.Little.Services"), ts: 1804283456, 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 1772747455.159 sable_ircd #x1B[2m2027-03-05T21:50:57.341009Z#x1B[0m #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(949786117912539136)), timestamp: 1804283456, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }) 1772747455.159 sable_ircd #x1B[2m2027-03-05T21:50:57.341839Z#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(949786117912539136)), timestamp: 1804283456, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] } 1772747455.159 sable_ircd #x1B[2m2027-03-05T21:50:57.343048Z#x1B[0m #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(949786117912539136)), timestamp: 1804283456, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747455.159 sable_ircd #x1B[2m2027-03-05T21:50:57.343657Z#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(949786117912539136)), timestamp: 1804283456, change: EventComplete(EventComplete), users_to_notify: [] } 1772747455.159 sable_ircd #x1B[2m2027-03-05T21:50:57.344572Z#x1B[0m #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(949786118055145473)), timestamp: 1804283456, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747455.159 sable_ircd #x1B[2m2027-03-05T21:50:57.344957Z#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(949786118055145473)), timestamp: 1804283456, change: EventComplete(EventComplete), users_to_notify: [] } 1772747455.164 sable_services #x1B[2m2027-03-05T21:50:57.414884Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786117912539136))]) } }#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(949786117912539136))] 1772747455.164 sable_services #x1B[2m2027-03-05T21:50:57.415638Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786117912539136))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [] 1772747455.165 sable_ircd #x1B[2m2027-03-05T21:50:57.432500Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786118310998018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786118055145473), 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(949786118310998018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786118055145473), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 949786111763288065, 99 => 949786118055145473) my clock=EventClock(1 => 949786118633558018, 99 => 949786118055145473) 1772747455.165 sable_ircd #x1B[2m2027-03-05T21:50:57.438454Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786118310998018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786118055145473), 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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786118310998018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065, 99 => 949786118055145473), 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:59809 (127.0.0.1:59809) 1772747455.169 sable_ircd #x1B[2m2027-03-05T21:50:57.493406Z#x1B[0m #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(949786118310998018)), timestamp: 1804283456, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }) 1772747455.169 sable_ircd #x1B[2m2027-03-05T21:50:57.494002Z#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(949786118310998018)), timestamp: 1804283456, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] } 1772747455.169 sable_ircd #x1B[2m2027-03-05T21:50:57.495515Z#x1B[0m #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(949786118310998018)), timestamp: 1804283456, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747455.169 sable_ircd #x1B[2m2027-03-05T21:50:57.496155Z#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(949786118310998018)), timestamp: 1804283456, change: EventComplete(EventComplete), users_to_notify: [] } 1772747455.205 sable_ircd #x1B[2m2027-03-05T21:50:58.032466Z#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), 1804283455), 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: [] 1772747455.224 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747455.224 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747455.224 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1772747455.224 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747455.224 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2027-03-05 21:50:56.865760649 UTC 1772747455.224 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747455.224 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 1772747455.224 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing 1772747455.224 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs + 1772747455.224 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747455.224 chkSvs -> S: CAP LS 302 1772747455.224 sable_ircd #x1B[2m2027-03-05T21:50:58.328424Z#x1B[0m #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 1772747455.224 sable_ircd #x1B[2m2027-03-05T21:50:58.329705Z#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" 1772747455.225 sable_ircd #x1B[2m2027-03-05T21:50:58.331664Z#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 1772747455.274 chkSvs -> S: PING synchronize292.610665259 1772747455.274 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 1772747455.275 sable_ircd #x1B[2m2027-03-05T21:50:59.080632Z#x1B[0m #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 1772747455.275 sable_ircd #x1B[2m2027-03-05T21:50:59.081609Z#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 synchronize292.610665259" 1772747455.275 sable_ircd #x1B[2m2027-03-05T21:50:59.083682Z#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 :synchronize292.610665259 1772747455.275 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize292.610665259 1772747455.275 chkSvs -> S: QUIT 1772747455.275 chkSvs -> S: PING synchronize292.611747422 1772747455.275 sable_ircd #x1B[2m2027-03-05T21:50:59.094201Z#x1B[0m #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 1772747455.275 sable_ircd #x1B[2m2027-03-05T21:50:59.095021Z#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" 1772747455.276 sable_ircd #x1B[2m2027-03-05T21:50:59.096623Z#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 1772747455.276 sable_ircd #x1B[2m2027-03-05T21:50:59.098462Z#x1B[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)) 1772747455.276 sable_ircd #x1B[2m2027-03-05T21:50:59.099159Z#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) 1772747455.276 S -> chkSvs: ERROR :Client quit 1772747455.276 sable_ircd #x1B[2m2027-03-05T21:50:59.100438Z#x1B[0m #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 1772747455.276 sable_ircd #x1B[2m2027-03-05T21:50:59.101304Z#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 synchronize292.611747422" 1772747455.276 sable_ircd #x1B[2m2027-03-05T21:50:59.101552Z#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(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 949786118633558018, 99 => 949786118310998018) my clock=EventClock(1 => 949786118633558018, 99 => 949786118310998018) 1772747455.276 chkSvs: disconnects from server. 1772747455.277 1: connects to server. 1772747455.277 1 -> S: CAP LS 302 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.108342Z#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 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.109507Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), 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:59809 (127.0.0.1:59809) 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.110002Z#x1B[0m #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 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.116850Z#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 } 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.118584Z#x1B[0m #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 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.119374Z#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 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.120304Z#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 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.122411Z#x1B[0m #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 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.123125Z#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"CAP LS 302" 1772747455.277 sable_ircd #x1B[2m2027-03-05T21:50:59.124720Z#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 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 1772747455.278 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747455.278 S -> 1: :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1772747455.278 1 -> S: CAP REQ :message-tags server-time echo-message batch labeled-response sasl draft/chathistory 1772747455.278 sable_ircd #x1B[2m2027-03-05T21:50:59.135201Z#x1B[0m #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 1772747455.278 sable_ircd #x1B[2m2027-03-05T21:50:59.135785Z#x1B[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")) 1772747455.278 sable_ircd #x1B[2m2027-03-05T21:50:59.136423Z#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 1772747455.278 sable_ircd #x1B[2m2027-03-05T21:50:59.137002Z#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: 1804283459, tv_nsec: 119967879 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747455.279 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747455.279 sable_ircd #x1B[2m2027-03-05T21:50:59.141997Z#x1B[0m #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 1772747455.279 sable_ircd #x1B[2m2027-03-05T21:50:59.142813Z#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"CAP REQ :message-tags server-time echo-message batch labeled-response sasl draft/chathistory" 1772747455.279 sable_ircd #x1B[2m2027-03-05T21:50:59.144786Z#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 CAP * ACK :message-tags server-time echo-message batch labeled-response sasl draft/chathistory 1772747455.279 sable_ircd #x1B[2m2027-03-05T21:50:59.145395Z#x1B[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), 3), ClientCapabilitySet(65599)) 1772747455.279 sable_ircd #x1B[2m2027-03-05T21:50:59.152470Z#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(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 949786128053964803, 99 => 949786118310998018) my clock=EventClock(1 => 949786128053964803, 99 => 949786118310998018) 1772747455.280 sable_ircd #x1B[2m2027-03-05T21:50:59.157062Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), 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:59809 (127.0.0.1:59809) 1772747455.280 sable_ircd #x1B[2m2027-03-05T21:50:59.159535Z#x1B[0m #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(949786128053964803)), timestamp: 1804283459, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(949786118625169408)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(949786118625169409)), user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 } }), users_to_notify: [] }) 1772747455.280 sable_ircd #x1B[2m2027-03-05T21:50:59.160254Z#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(949786128053964803)), timestamp: 1804283459, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(949786118625169408)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(949786118625169409)), user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 } }), users_to_notify: [] } 1772747455.280 sable_ircd #x1B[2m2027-03-05T21:50:59.161429Z#x1B[0m #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(949786128053964803)), timestamp: 1804283459, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747455.280 sable_ircd #x1B[2m2027-03-05T21:50:59.161983Z#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(949786128053964803)), timestamp: 1804283459, change: EventComplete(EventComplete), users_to_notify: [] } 1772747455.283 sable_ircd #x1B[2m2027-03-05T21:50:59.213463Z#x1B[0m #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(949786128267874308)), timestamp: 1804283459, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(949786118625169408)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1772747455.283 sable_ircd #x1B[2m2027-03-05T21:50:59.214432Z#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(949786128267874308)), timestamp: 1804283459, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(949786118625169408)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1772747455.283 sable_ircd #x1B[2m2027-03-05T21:50:59.215509Z#x1B[0m #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(949786128267874308)), timestamp: 1804283459, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747455.284 sable_ircd #x1B[2m2027-03-05T21:50:59.216052Z#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(949786128267874308)), timestamp: 1804283459, change: EventComplete(EventComplete), users_to_notify: [] } 1772747455.284 sable_services #x1B[2m2027-03-05T21:50:59.222639Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), 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(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 949786128053964803, 99 => 949786118310998018) my clock=EventClock(1 => 949786111763288065, 99 => 949786118310998018) 1772747455.284 sable_services #x1B[2m2027-03-05T21:50:59.223768Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), 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(949786128053964803))] 1772747455.285 sable_services #x1B[2m2027-03-05T21:50:59.229122Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), 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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), 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:51511 (127.0.0.1:51511) 1772747455.319 S -> 1: :My.Little.Server CAP * ACK :message-tags server-time echo-message batch labeled-response sasl draft/chathistory 1772747455.320 1 -> S: NICK bar 1772747455.320 1 -> S: USER username * * :Realname 1772747455.320 1 -> S: CAP END 1772747455.320 sable_ircd #x1B[2m2027-03-05T21:50:59.763828Z#x1B[0m #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 1772747455.320 sable_ircd #x1B[2m2027-03-05T21:50:59.765030Z#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 bar" 1772747455.320 sable_ircd #x1B[2m2027-03-05T21:50:59.767787Z#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: 1804283459, tv_nsec: 119967879 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("bar")), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747455.320 sable_ircd #x1B[2m2027-03-05T21:50:59.769153Z#x1B[0m #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 1772747455.320 sable_ircd #x1B[2m2027-03-05T21:50:59.769901Z#x1B[0m #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 1772747455.321 sable_ircd #x1B[2m2027-03-05T21:50:59.770620Z#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 username * * :Realname" 1772747455.321 sable_ircd #x1B[2m2027-03-05T21:50:59.772198Z#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: 1804283459, tv_nsec: 119967879 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("bar")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747455.321 sable_ircd #x1B[2m2027-03-05T21:50:59.773366Z#x1B[0m #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 1772747455.321 sable_ircd #x1B[2m2027-03-05T21:50:59.774114Z#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"CAP END" 1772747455.321 sable_services #x1B[2m2027-03-05T21:50:59.773033Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 949786118633558018, 99 => 949786118310998018) my clock=EventClock(1 => 949786111763288065, 99 => 949786118310998018) 1772747455.321 sable_services #x1B[2m2027-03-05T21:50:59.774117Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(949786118633558018))] 1772747455.321 sable_services #x1B[2m2027-03-05T21:50:59.780348Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), 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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), 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:51511 (127.0.0.1:51511) 1772747455.326 sable_ircd #x1B[2m2027-03-05T21:50:59.847371Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786128053964803))]) } }#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(949786128053964803))] 1772747455.326 sable_ircd #x1B[2m2027-03-05T21:50:59.848260Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786128053964803))]) } }#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(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), details: UserDisconnect(UserDisconnect) }] 1772747455.338 sable_ircd #x1B[2m2027-03-05T21:51:00.027799Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::complete_progress #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 1804283459, tv_nsec: 119967879 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("bar")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mflag#x1B[0m#x1B[2m=#x1B[0mCapNegotiation #x1B[3mresult#x1B[0m#x1B[2m=#x1B[0mtrue 1772747455.338 sable_ircd #x1B[2m2027-03-05T21:51:00.029584Z#x1B[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)) 1772747455.338 sable_ircd #x1B[2m2027-03-05T21:51:00.033047Z#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(949786131958861829)), timestamp: 1804283460, clock: EventClock(1 => 949786128267874308, 99 => 949786118310998018), target: User(UserId(Snowflake(949786131954667522))), details: NewUser(NewUser { nickname: Nickname("bar"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(949786131954667523)), NewUserConnection { user: UserId(Snowflake(949786131954667522)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283460 })) }) }; event clock=EventClock(1 => 949786128267874308, 99 => 949786118310998018) my clock=EventClock(1 => 949786128267874308, 99 => 949786118310998018) 1772747455.338 sable_ircd #x1B[2m2027-03-05T21:51:00.038340Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786131958861829)), timestamp: 1804283460, clock: EventClock(1 => 949786128267874308, 99 => 949786118310998018), target: User(UserId(Snowflake(949786131954667522))), details: NewUser(NewUser { nickname: Nickname("bar"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(949786131954667523)), NewUserConnection { user: UserId(Snowflake(949786131954667522)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283460 })) }) }) } #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:59809 (127.0.0.1:59809) 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.071599Z#x1B[0m #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(949786131958861829)), timestamp: 1804283460, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(949786131954667522)), 1) }), users_to_notify: [] }) 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.072309Z#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(949786131958861829)), timestamp: 1804283460, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(949786131954667522)), 1) }), users_to_notify: [] } 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.073275Z#x1B[0m #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(949786131958861829)), timestamp: 1804283460, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(949786131954667522)), 2), connection: UserConnectionId(Snowflake(949786131954667523)) }), users_to_notify: [] }) 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.073789Z#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(949786131958861829)), timestamp: 1804283460, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(949786131954667522)), 2), connection: UserConnectionId(Snowflake(949786131954667523)) }), users_to_notify: [] } 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.074788Z#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 bar :Welcome to the test Internet Relay Chat network, bar 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.075371Z#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 bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.075859Z#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 bar :This server was created 2027-03-05 21:51:00.075675074 UTC 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.076266Z#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 bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.076751Z#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 bar 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 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.077169Z#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 bar :MOTD File is missing 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.077582Z#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): :bar!username@localhost MODE bar + 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.077965Z#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 bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.078887Z#x1B[0m #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(949786131958861829)), timestamp: 1804283460, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747455.341 sable_ircd #x1B[2m2027-03-05T21:51:00.079425Z#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(949786131958861829)), timestamp: 1804283460, change: EventComplete(EventComplete), users_to_notify: [] } 1772747455.341 S -> 1: :My.Little.Server 001 bar :Welcome to the test Internet Relay Chat network, bar 1772747455.342 1 -> S: PING foo 1772747455.342 sable_ircd #x1B[2m2027-03-05T21:51:00.091511Z#x1B[0m #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 1772747455.342 sable_ircd #x1B[2m2027-03-05T21:51:00.092245Z#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 foo" 1772747455.362 sable_ircd #x1B[2m2027-03-05T21:51:00.387763Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786118633558018))]) } }#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(949786118633558018))] 1772747455.362 sable_ircd #x1B[2m2027-03-05T21:51:00.388482Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786118633558018))]) } }#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(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }] 1772747455.367 sable_services #x1B[2m2027-03-05T21:51:00.460358Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), 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(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), details: UserDisconnect(UserDisconnect) }] 1772747455.367 sable_services #x1B[2m2027-03-05T21:51:00.461560Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), 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[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 949786118633558018, 99 => 949786118310998018) my clock=EventClock(1 => 949786111763288065, 99 => 949786118310998018) 1772747455.367 sable_services #x1B[2m2027-03-05T21:51:00.462222Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), 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[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(949786118633558018))] 1772747455.382 sable_services #x1B[2m2027-03-05T21:51:00.687308Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786131958861829)), timestamp: 1804283460, clock: EventClock(1 => 949786128267874308, 99 => 949786118310998018), target: User(UserId(Snowflake(949786131954667522))), details: NewUser(NewUser { nickname: Nickname("bar"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(949786131954667523)), NewUserConnection { user: UserId(Snowflake(949786131954667522)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283460 })) }) }) } }#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(949786131958861829)), timestamp: 1804283460, clock: EventClock(1 => 949786128267874308, 99 => 949786118310998018), target: User(UserId(Snowflake(949786131954667522))), details: NewUser(NewUser { nickname: Nickname("bar"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(949786131954667523)), NewUserConnection { user: UserId(Snowflake(949786131954667522)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283460 })) }) }; event clock=EventClock(1 => 949786128267874308, 99 => 949786118310998018) my clock=EventClock(1 => 949786111763288065, 99 => 949786118310998018) 1772747455.382 sable_services #x1B[2m2027-03-05T21:51:00.688359Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786131958861829)), timestamp: 1804283460, clock: EventClock(1 => 949786128267874308, 99 => 949786118310998018), target: User(UserId(Snowflake(949786131954667522))), details: NewUser(NewUser { nickname: Nickname("bar"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(949786131954667523)), NewUserConnection { user: UserId(Snowflake(949786131954667522)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283460 })) }) }) } }#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(949786128267874308))] 1772747455.382 sable_services #x1B[2m2027-03-05T21:51:00.693592Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786131958861829)), timestamp: 1804283460, clock: EventClock(1 => 949786128267874308, 99 => 949786118310998018), target: User(UserId(Snowflake(949786131954667522))), details: NewUser(NewUser { nickname: Nickname("bar"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(949786131954667523)), NewUserConnection { user: UserId(Snowflake(949786131954667522)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283460 })) }) }) } }#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786131958861829)), timestamp: 1804283460, clock: EventClock(1 => 949786128267874308, 99 => 949786118310998018), target: User(UserId(Snowflake(949786131954667522))), details: NewUser(NewUser { nickname: Nickname("bar"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(949786131954667523)), NewUserConnection { user: UserId(Snowflake(949786131954667522)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283460 })) }) }) } #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:51511 (127.0.0.1:51511) 1772747455.403 sable_services #x1B[2m2027-03-05T21:51:01.000971Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }]) } }#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(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }] 1772747455.403 sable_services #x1B[2m2027-03-05T21:51:01.002394Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }; event clock=EventClock(1 => 949786111763288065) my clock=EventClock(1 => 949786111763288065, 99 => 949786118310998018) 1772747455.403 sable_services #x1B[2m2027-03-05T21:51:01.003601Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(949786128053964803)), timestamp: 1804283459, clock: EventClock(1 => 949786118633558018, 99 => 949786118310998018), target: UserConnection(UserConnectionId(Snowflake(949786118625169409))), details: UserDisconnect(UserDisconnect) } 1772747455.403 sable_services #x1B[2m2027-03-05T21:51:01.004364Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1772747455.403 sable_services #x1B[2m2027-03-05T21:51:01.004878Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(949786131958861829)), timestamp: 1804283460, clock: EventClock(1 => 949786128267874308, 99 => 949786118310998018), target: User(UserId(Snowflake(949786131954667522))), details: NewUser(NewUser { nickname: Nickname("bar"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(949786131954667523)), NewUserConnection { user: UserId(Snowflake(949786131954667522)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283460 })) }) } 1772747455.408 sable_ircd #x1B[2m2027-03-05T21:51:01.077084Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786118633558018))]) } }#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(949786118633558018))] 1772747455.408 sable_ircd #x1B[2m2027-03-05T21:51:01.077842Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786118633558018))]) } }#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(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }] 1772747455.409 sable_ircd #x1B[2m2027-03-05T21:51:01.099392Z#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 :foo 1772747455.423 sable_ircd #x1B[2m2027-03-05T21:51:01.302005Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786128267874308))]) } }#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(949786128267874308))] 1772747455.423 sable_ircd #x1B[2m2027-03-05T21:51:01.302625Z#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), 1804283455), content: GetEvent([EventId(Snowflake(949786128267874308))]) } }#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(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1772747455.442 1 -> S: PING synchronize292.77835936 1772747455.442 S -> 1: :My.Little.Server 002 bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747455.442 S -> 1: :My.Little.Server 003 bar :This server was created 2027-03-05 21:51:00.075675074 UTC 1772747455.442 S -> 1: :My.Little.Server 004 bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747455.442 S -> 1: :My.Little.Server 005 bar 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 1772747455.442 S -> 1: :My.Little.Server 422 bar :MOTD File is missing 1772747455.442 S -> 1: :bar!username@localhost MODE bar + 1772747455.442 S -> 1: :My.Little.Server NOTICE bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747455.442 S -> 1: :My.Little.Server PONG My.Little.Server :foo 1772747455.442 sable_ircd #x1B[2m2027-03-05T21:51:01.596146Z#x1B[0m #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 1772747455.442 sable_ircd #x1B[2m2027-03-05T21:51:01.596979Z#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 synchronize292.77835936" 1772747455.449 sable_services #x1B[2m2027-03-05T21:51:01.692517Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }]) } }#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(949786118633558018)), timestamp: 1804283456, clock: EventClock(1 => 949786111763288065), target: User(UserId(Snowflake(949786118625169408))), 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(949786118625169409)), NewUserConnection { user: UserId(Snowflake(949786118625169408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1804283456 })) }) }] 1772747455.464 sable_services #x1B[2m2027-03-05T21:51:01.917058Z#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), 1804283455), content: BulkEvents([Event { id: EventId(Snowflake(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), details: UserQuit(UserQuit { message: "Client Quit" }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(949786128267874308)), timestamp: 1804283459, clock: EventClock(1 => 949786128053964803, 99 => 949786118310998018), target: User(UserId(Snowflake(949786118625169408))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1772747455.476 sable_ircd #x1B[2m2027-03-05T21:51:02.100843Z#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 :synchronize292.77835936 1772747455.476 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize292.77835936 1772747456.177 1 -> S: JOIN #chanbd556588e2cf82fa7099f810 1772747456.178 sable_ircd #x1B[2m2027-03-05T21:51:12.627837Z#x1B[0m #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 1772747456.178 sable_ircd #x1B[2m2027-03-05T21:51:12.628790Z#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"JOIN #chanbd556588e2cf82fa7099f810" 1772747456.178 sable_ircd #x1B[2m2027-03-05T21:51:12.633294Z#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(949786184807092230)), timestamp: 1804283472, clock: EventClock(1 => 949786131958861829, 99 => 949786118310998018), target: Channel(ChannelId(Snowflake(949786184802897924))), details: NewChannel(NewChannel { name: ChannelName("#chanbd556588e2cf82fa7099f810"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 949786131958861829, 99 => 949786118310998018) my clock=EventClock(1 => 949786131958861829, 99 => 949786118310998018) 1772747456.178 sable_ircd #x1B[2m2027-03-05T21:51:12.640285Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786184807092230)), timestamp: 1804283472, clock: EventClock(1 => 949786131958861829, 99 => 949786118310998018), target: Channel(ChannelId(Snowflake(949786184802897924))), details: NewChannel(NewChannel { name: ChannelName("#chanbd556588e2cf82fa7099f810"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }) } #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:59809 (127.0.0.1:59809) 1772747456.180 sable_ircd #x1B[2m2027-03-05T21:51:12.667857Z#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(949786184953892871)), timestamp: 1804283472, clock: EventClock(1 => 949786184807092230, 99 => 949786118310998018), target: Membership(MembershipId(UserId(Snowflake(949786131954667522)), ChannelId(Snowflake(949786184802897924)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(949786184802897924)), user: UserId(Snowflake(949786131954667522)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 949786184807092230, 99 => 949786118310998018) my clock=EventClock(1 => 949786184807092230, 99 => 949786118310998018) 1772747456.180 sable_ircd #x1B[2m2027-03-05T21:51:12.670508Z#x1B[0m #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 1772747456.181 sable_ircd #x1B[2m2027-03-05T21:51:12.674042Z#x1B[0m #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(949786184807092230)), timestamp: 1804283472, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747456.181 sable_ircd #x1B[2m2027-03-05T21:51:12.675257Z#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(949786184807092230)), timestamp: 1804283472, change: EventComplete(EventComplete), users_to_notify: [] } 1772747456.181 sable_ircd #x1B[2m2027-03-05T21:51:12.675445Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786184953892871)), timestamp: 1804283472, clock: EventClock(1 => 949786184807092230, 99 => 949786118310998018), target: Membership(MembershipId(UserId(Snowflake(949786131954667522)), ChannelId(Snowflake(949786184802897924)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(949786184802897924)), user: UserId(Snowflake(949786131954667522)), permissions: MembershipFlagSet(1) }) }) } #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:59809 (127.0.0.1:59809) 1772747456.183 sable_ircd #x1B[2m2027-03-05T21:51:12.705529Z#x1B[0m #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(949786184953892871)), timestamp: 1804283472, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(949786131954667522)), ChannelId(Snowflake(949786184802897924))), user: HistoricUserId(UserId(Snowflake(949786131954667522)), 2) }), users_to_notify: [UserId(Snowflake(949786131954667522))] }) 1772747456.183 sable_ircd #x1B[2m2027-03-05T21:51:12.706417Z#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(949786184953892871)), timestamp: 1804283472, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(949786131954667522)), ChannelId(Snowflake(949786184802897924))), user: HistoricUserId(UserId(Snowflake(949786131954667522)), 2) }), users_to_notify: [UserId(Snowflake(949786131954667522))] } 1772747456.183 sable_ircd #x1B[2m2027-03-05T21:51:12.707654Z#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): @time=2027-03-05T21:51:12.000Z :bar!username@localhost JOIN #chanbd556588e2cf82fa7099f810 1772747456.183 sable_ircd #x1B[2m2027-03-05T21:51:12.708560Z#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): :bar!username@localhost MODE #chanbd556588e2cf82fa7099f810 +o bar 1772747456.183 sable_ircd #x1B[2m2027-03-05T21:51:12.709708Z#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 353 bar = #chanbd556588e2cf82fa7099f810 :@bar 1772747456.183 sable_ircd #x1B[2m2027-03-05T21:51:12.710351Z#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 366 bar #chanbd556588e2cf82fa7099f810 :End of names list 1772747456.183 sable_ircd #x1B[2m2027-03-05T21:51:12.711218Z#x1B[0m #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(949786184953892871)), timestamp: 1804283472, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747456.183 sable_ircd #x1B[2m2027-03-05T21:51:12.711725Z#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(949786184953892871)), timestamp: 1804283472, change: EventComplete(EventComplete), users_to_notify: [] } 1772747456.222 sable_services #x1B[2m2027-03-05T21:51:13.289342Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786184807092230)), timestamp: 1804283472, clock: EventClock(1 => 949786131958861829, 99 => 949786118310998018), target: Channel(ChannelId(Snowflake(949786184802897924))), details: NewChannel(NewChannel { name: ChannelName("#chanbd556588e2cf82fa7099f810"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }) } }#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(949786184807092230)), timestamp: 1804283472, clock: EventClock(1 => 949786131958861829, 99 => 949786118310998018), target: Channel(ChannelId(Snowflake(949786184802897924))), details: NewChannel(NewChannel { name: ChannelName("#chanbd556588e2cf82fa7099f810"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 949786131958861829, 99 => 949786118310998018) my clock=EventClock(1 => 949786131958861829, 99 => 949786118310998018) 1772747456.222 sable_services #x1B[2m2027-03-05T21:51:13.295094Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786184807092230)), timestamp: 1804283472, clock: EventClock(1 => 949786131958861829, 99 => 949786118310998018), target: Channel(ChannelId(Snowflake(949786184802897924))), details: NewChannel(NewChannel { name: ChannelName("#chanbd556588e2cf82fa7099f810"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }) } }#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786184807092230)), timestamp: 1804283472, clock: EventClock(1 => 949786131958861829, 99 => 949786118310998018), target: Channel(ChannelId(Snowflake(949786184802897924))), details: NewChannel(NewChannel { name: ChannelName("#chanbd556588e2cf82fa7099f810"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }) } #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:51511 (127.0.0.1:51511) 1772747456.225 sable_services #x1B[2m2027-03-05T21:51:13.325320Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786184953892871)), timestamp: 1804283472, clock: EventClock(1 => 949786184807092230, 99 => 949786118310998018), target: Membership(MembershipId(UserId(Snowflake(949786131954667522)), ChannelId(Snowflake(949786184802897924)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(949786184802897924)), user: UserId(Snowflake(949786131954667522)), permissions: MembershipFlagSet(1) }) }) } }#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(949786184953892871)), timestamp: 1804283472, clock: EventClock(1 => 949786184807092230, 99 => 949786118310998018), target: Membership(MembershipId(UserId(Snowflake(949786131954667522)), ChannelId(Snowflake(949786184802897924)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(949786184802897924)), user: UserId(Snowflake(949786131954667522)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 949786184807092230, 99 => 949786118310998018) my clock=EventClock(1 => 949786184807092230, 99 => 949786118310998018) 1772747456.225 sable_services #x1B[2m2027-03-05T21:51:13.330531Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786184953892871)), timestamp: 1804283472, clock: EventClock(1 => 949786184807092230, 99 => 949786118310998018), target: Membership(MembershipId(UserId(Snowflake(949786131954667522)), ChannelId(Snowflake(949786184802897924)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(949786184802897924)), user: UserId(Snowflake(949786131954667522)), permissions: MembershipFlagSet(1) }) }) } }#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786184953892871)), timestamp: 1804283472, clock: EventClock(1 => 949786184807092230, 99 => 949786118310998018), target: Membership(MembershipId(UserId(Snowflake(949786131954667522)), ChannelId(Snowflake(949786184802897924)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(949786184802897924)), user: UserId(Snowflake(949786131954667522)), permissions: MembershipFlagSet(1) }) }) } #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:51511 (127.0.0.1:51511) 1772747456.277 1 -> S: PING synchronize293.613945515 1772747456.277 S -> 1: @time=2027-03-05T21:51:12.000Z :bar!username@localhost JOIN #chanbd556588e2cf82fa7099f810 1772747456.277 S -> 1: :bar!username@localhost MODE #chanbd556588e2cf82fa7099f810 +o bar 1772747456.278 S -> 1: :My.Little.Server 353 bar = #chanbd556588e2cf82fa7099f810 :@bar 1772747456.278 S -> 1: :My.Little.Server 366 bar #chanbd556588e2cf82fa7099f810 :End of names list 1772747456.278 sable_ircd #x1B[2m2027-03-05T21:51:14.130750Z#x1B[0m #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 1772747456.278 sable_ircd #x1B[2m2027-03-05T21:51:14.131624Z#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 synchronize293.613945515" 1772747456.278 sable_ircd #x1B[2m2027-03-05T21:51:14.133294Z#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 :synchronize293.613945515 1772747456.278 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize293.613945515 1772747456.378 1 -> S: PING synchronize293.715053337 1772747456.380 sable_ircd #x1B[2m2027-03-05T21:51:15.659711Z#x1B[0m #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 1772747456.380 sable_ircd #x1B[2m2027-03-05T21:51:15.663958Z#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 synchronize293.715053337" 1772747456.380 sable_ircd #x1B[2m2027-03-05T21:51:15.666262Z#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 :synchronize293.715053337 1772747456.381 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize293.715053337 1772747456.481 1 -> S: PING synchronize293.817315321 1772747456.481 sable_ircd #x1B[2m2027-03-05T21:51:17.180919Z#x1B[0m #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 1772747456.481 sable_ircd #x1B[2m2027-03-05T21:51:17.181975Z#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 synchronize293.817315321" 1772747456.481 sable_ircd #x1B[2m2027-03-05T21:51:17.184529Z#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 :synchronize293.817315321 1772747456.482 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize293.817315321 1772747456.482 1 -> S: PRIVMSG #chanbd556588e2cf82fa7099f810 :this is a message 1772747456.482 sable_ircd #x1B[2m2027-03-05T21:51:17.194887Z#x1B[0m #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 1772747456.482 sable_ircd #x1B[2m2027-03-05T21:51:17.195528Z#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"PRIVMSG #chanbd556588e2cf82fa7099f810 :this is a message" 1772747456.483 sable_ircd #x1B[2m2027-03-05T21:51:17.200242Z#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(949786203962478600)), timestamp: 1804283477, clock: EventClock(1 => 949786184953892871, 99 => 949786118310998018), target: Message(MessageId(Uuid7(01a417ac-fccd-7603-bf3f-17c12046dc4c))), details: NewMessage(NewMessage { source: UserId(Snowflake(949786131954667522)), target: Channel(ChannelId(Snowflake(949786184802897924))), message_type: Privmsg, text: "this is a message" }) }; event clock=EventClock(1 => 949786184953892871, 99 => 949786118310998018) my clock=EventClock(1 => 949786184953892871, 99 => 949786118310998018) 1772747456.483 sable_ircd #x1B[2m2027-03-05T21:51:17.202571Z#x1B[0m #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 1772747456.483 sable_ircd #x1B[2m2027-03-05T21:51:17.206115Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786203962478600)), timestamp: 1804283477, clock: EventClock(1 => 949786184953892871, 99 => 949786118310998018), target: Message(MessageId(Uuid7(01a417ac-fccd-7603-bf3f-17c12046dc4c))), details: NewMessage(NewMessage { source: UserId(Snowflake(949786131954667522)), target: Channel(ChannelId(Snowflake(949786184802897924))), message_type: Privmsg, text: "this is a message" }) }) } #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:59809 (127.0.0.1:59809) 1772747456.485 sable_ircd #x1B[2m2027-03-05T21:51:17.237841Z#x1B[0m #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(949786203962478600)), timestamp: 1804283477, change: NewMessage(NewMessage { message: MessageId(Uuid7(01a417ac-fccd-7603-bf3f-17c12046dc4c)), source: User(HistoricUserId(UserId(Snowflake(949786131954667522)), 2)), target: Channel(ChannelId(Snowflake(949786184802897924))) }), users_to_notify: [UserId(Snowflake(949786131954667522))] }) 1772747456.485 sable_ircd #x1B[2m2027-03-05T21:51:17.238711Z#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(949786203962478600)), timestamp: 1804283477, change: NewMessage(NewMessage { message: MessageId(Uuid7(01a417ac-fccd-7603-bf3f-17c12046dc4c)), source: User(HistoricUserId(UserId(Snowflake(949786131954667522)), 2)), target: Channel(ChannelId(Snowflake(949786184802897924))) }), users_to_notify: [UserId(Snowflake(949786131954667522))] } 1772747456.485 sable_ircd #x1B[2m2027-03-05T21:51:17.239982Z#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): @time=2027-03-05T21:51:17.000Z;msgid=01a417ac-fccd-7603-bf3f-17c12046dc4c :bar!username@localhost PRIVMSG #chanbd556588e2cf82fa7099f810 :this is a message 1772747456.485 sable_ircd #x1B[2m2027-03-05T21:51:17.241046Z#x1B[0m #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(949786203962478600)), timestamp: 1804283477, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747456.485 sable_ircd #x1B[2m2027-03-05T21:51:17.241616Z#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(949786203962478600)), timestamp: 1804283477, change: EventComplete(EventComplete), users_to_notify: [] } 1772747456.526 sable_services #x1B[2m2027-03-05T21:51:17.848771Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786203962478600)), timestamp: 1804283477, clock: EventClock(1 => 949786184953892871, 99 => 949786118310998018), target: Message(MessageId(Uuid7(01a417ac-fccd-7603-bf3f-17c12046dc4c))), details: NewMessage(NewMessage { source: UserId(Snowflake(949786131954667522)), target: Channel(ChannelId(Snowflake(949786184802897924))), message_type: Privmsg, text: "this is a message" }) }) } }#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(949786203962478600)), timestamp: 1804283477, clock: EventClock(1 => 949786184953892871, 99 => 949786118310998018), target: Message(MessageId(Uuid7(01a417ac-fccd-7603-bf3f-17c12046dc4c))), details: NewMessage(NewMessage { source: UserId(Snowflake(949786131954667522)), target: Channel(ChannelId(Snowflake(949786184802897924))), message_type: Privmsg, text: "this is a message" }) }; event clock=EventClock(1 => 949786184953892871, 99 => 949786118310998018) my clock=EventClock(1 => 949786184953892871, 99 => 949786118310998018) 1772747456.526 sable_services #x1B[2m2027-03-05T21:51:17.855687Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786203962478600)), timestamp: 1804283477, clock: EventClock(1 => 949786184953892871, 99 => 949786118310998018), target: Message(MessageId(Uuid7(01a417ac-fccd-7603-bf3f-17c12046dc4c))), details: NewMessage(NewMessage { source: UserId(Snowflake(949786131954667522)), target: Channel(ChannelId(Snowflake(949786184802897924))), message_type: Privmsg, text: "this is a message" }) }) } }#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786203962478600)), timestamp: 1804283477, clock: EventClock(1 => 949786184953892871, 99 => 949786118310998018), target: Message(MessageId(Uuid7(01a417ac-fccd-7603-bf3f-17c12046dc4c))), details: NewMessage(NewMessage { source: UserId(Snowflake(949786131954667522)), target: Channel(ChannelId(Snowflake(949786184802897924))), message_type: Privmsg, text: "this is a message" }) }) } #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:51511 (127.0.0.1:51511) 1772747456.582 1 -> S: PING synchronize293.91858637 1772747456.582 S -> 1: @time=2027-03-05T21:51:17.000Z;msgid=01a417ac-fccd-7603-bf3f-17c12046dc4c :bar!username@localhost PRIVMSG #chanbd556588e2cf82fa7099f810 :this is a message 1772747456.583 sable_ircd #x1B[2m2027-03-05T21:51:18.701827Z#x1B[0m #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 1772747456.583 sable_ircd #x1B[2m2027-03-05T21:51:18.702932Z#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 synchronize293.91858637" 1772747456.583 sable_ircd #x1B[2m2027-03-05T21:51:18.705051Z#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 :synchronize293.91858637 1772747456.583 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize293.91858637 1772747457.250 sable_history #x1B[2m2027-03-05T21:51:56.356768Z#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(949786368199041027)), timestamp: 1804283516, clock: EventClock(1 => 949786103294988289, 50 => 949786117006368770), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283516 }) }; event clock=EventClock(1 => 949786103294988289, 50 => 949786117006368770) my clock=EventClock(1 => 949786103294988289, 50 => 949786117006368770) 1772747457.250 sable_history #x1B[2m2027-03-05T21:51:56.364029Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786368199041027)), timestamp: 1804283516, clock: EventClock(1 => 949786103294988289, 50 => 949786117006368770), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:58223. Last error: I/O error: Connection refused (os error 111) 1772747457.250 sable_history #x1B[2m2027-03-05T21:51:56.365424Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786368199041027)), timestamp: 1804283516, clock: EventClock(1 => 949786103294988289, 50 => 949786117006368770), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1772747457.250 sable_history #x1B[2m2027-03-05T21:51:56.366582Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111) 1772747457.686 sable_history #x1B[2m2027-03-05T21:51:56.591219Z#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(949786369180508163)), timestamp: 1804283516, clock: EventClock(1 => 949786183724961807, 50 => 949786117920727042, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283516 }) }; event clock=EventClock(1 => 949786183724961807, 50 => 949786117920727042, 99 => 949786173562564612) my clock=EventClock(1 => 949786183724961807, 50 => 949786117920727042, 99 => 949786173562564612) 1772747457.686 sable_history #x1B[2m2027-03-05T21:51:56.597544Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786369180508163)), timestamp: 1804283516, clock: EventClock(1 => 949786183724961807, 50 => 949786117920727042, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:37225. Last error: I/O error: Connection refused (os error 111) 1772747457.686 sable_history #x1B[2m2027-03-05T21:51:56.598248Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786369180508163)), timestamp: 1804283516, clock: EventClock(1 => 949786183724961807, 50 => 949786117920727042, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1772747457.686 sable_history #x1B[2m2027-03-05T21:51:56.599194Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111) 1772747457.686 sable_history #x1B[2m2027-03-05T21:51:56.600057Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786369180508163)), timestamp: 1804283516, clock: EventClock(1 => 949786183724961807, 50 => 949786117920727042, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:44627. Last error: I/O error: Connection refused (os error 111) 1772747457.686 sable_history #x1B[2m2027-03-05T21:51:56.600640Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786369180508163)), timestamp: 1804283516, clock: EventClock(1 => 949786183724961807, 50 => 949786117920727042, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1772747457.686 sable_history #x1B[2m2027-03-05T21:51:56.601464Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111) 1772747459.015 sable_ircd #x1B[2m2027-03-05T21:51:55.191508Z#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(949786363308281865)), timestamp: 1804283515, clock: EventClock(1 => 949786203962478600, 99 => 949786118310998018), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283515 }) }; event clock=EventClock(1 => 949786203962478600, 99 => 949786118310998018) my clock=EventClock(1 => 949786203962478600, 99 => 949786118310998018) 1772747459.016 sable_ircd #x1B[2m2027-03-05T21:51:55.197188Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786363308281865)), timestamp: 1804283515, clock: EventClock(1 => 949786203962478600, 99 => 949786118310998018), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283515 }) }) } #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:59809 (127.0.0.1:59809) 1772747459.016 sable_ircd #x1B[2m2027-03-05T21:51:55.203528Z#x1B[0m #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 1772747459.018 sable_ircd #x1B[2m2027-03-05T21:51:55.227414Z#x1B[0m #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(949786363308281865)), timestamp: 1804283515, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747459.018 sable_ircd #x1B[2m2027-03-05T21:51:55.228135Z#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(949786363308281865)), timestamp: 1804283515, change: EventComplete(EventComplete), users_to_notify: [] } 1772747459.059 sable_services #x1B[2m2027-03-05T21:51:55.843900Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786363308281865)), timestamp: 1804283515, clock: EventClock(1 => 949786203962478600, 99 => 949786118310998018), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283515 }) }) } }#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(949786363308281865)), timestamp: 1804283515, clock: EventClock(1 => 949786203962478600, 99 => 949786118310998018), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283515 }) }; event clock=EventClock(1 => 949786203962478600, 99 => 949786118310998018) my clock=EventClock(1 => 949786203962478600, 99 => 949786118310998018) 1772747459.059 sable_services #x1B[2m2027-03-05T21:51:55.848808Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786363308281865)), timestamp: 1804283515, clock: EventClock(1 => 949786203962478600, 99 => 949786118310998018), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283515 }) }) } }#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786363308281865)), timestamp: 1804283515, clock: EventClock(1 => 949786203962478600, 99 => 949786118310998018), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283515 }) }) } #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:51511 (127.0.0.1:51511) 1772747459.115 sable_services #x1B[2m2027-03-05T21:51:56.686778Z#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(949786369583362051)), timestamp: 1804283516, clock: EventClock(1 => 949786363308281865, 99 => 949786118310998018), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283516 }) }; event clock=EventClock(1 => 949786363308281865, 99 => 949786118310998018) my clock=EventClock(1 => 949786363308281865, 99 => 949786118310998018) 1772747459.116 sable_services #x1B[2m2027-03-05T21:51:56.692992Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786369583362051)), timestamp: 1804283516, clock: EventClock(1 => 949786363308281865, 99 => 949786118310998018), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } #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:51511 (127.0.0.1:51511) 1772747459.160 sable_ircd #x1B[2m2027-03-05T21:51:57.359045Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786369583362051)), timestamp: 1804283516, clock: EventClock(1 => 949786363308281865, 99 => 949786118310998018), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } }#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(949786369583362051)), timestamp: 1804283516, clock: EventClock(1 => 949786363308281865, 99 => 949786118310998018), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283516 }) }; event clock=EventClock(1 => 949786363308281865, 99 => 949786118310998018) my clock=EventClock(1 => 949786363308281865, 99 => 949786118310998018) 1772747459.160 sable_ircd #x1B[2m2027-03-05T21:51:57.363655Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786369583362051)), timestamp: 1804283516, clock: EventClock(1 => 949786363308281865, 99 => 949786118310998018), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } }#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786369583362051)), timestamp: 1804283516, clock: EventClock(1 => 949786363308281865, 99 => 949786118310998018), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283516 }) }) } #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:59809 (127.0.0.1:59809) 1772747459.162 sable_ircd #x1B[2m2027-03-05T21:51:57.393989Z#x1B[0m #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(949786369583362051)), timestamp: 1804283516, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747459.162 sable_ircd #x1B[2m2027-03-05T21:51:57.394828Z#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(949786369583362051)), timestamp: 1804283516, change: EventComplete(EventComplete), users_to_notify: [] } 1772747461.250 sable_history #x1B[2m2027-03-05T21:52:56.357713Z#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(949786619857281028)), timestamp: 1804283576, clock: EventClock(1 => 949786103294988289, 50 => 949786368199041027), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283576 }) }; event clock=EventClock(1 => 949786103294988289, 50 => 949786368199041027) my clock=EventClock(1 => 949786103294988289, 50 => 949786368199041027) 1772747461.250 sable_history #x1B[2m2027-03-05T21:52:56.365258Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786619857281028)), timestamp: 1804283576, clock: EventClock(1 => 949786103294988289, 50 => 949786368199041027), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:58223. Last error: I/O error: Connection refused (os error 111) 1772747461.250 sable_history #x1B[2m2027-03-05T21:52:56.366001Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786619857281028)), timestamp: 1804283576, clock: EventClock(1 => 949786103294988289, 50 => 949786368199041027), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1772747461.251 sable_history #x1B[2m2027-03-05T21:52:56.366794Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111) 1772747461.686 sable_history #x1B[2m2027-03-05T21:52:56.592291Z#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(949786620842942468)), timestamp: 1804283576, clock: EventClock(1 => 949786183724961807, 50 => 949786369180508163, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283576 }) }; event clock=EventClock(1 => 949786183724961807, 50 => 949786369180508163, 99 => 949786173562564612) my clock=EventClock(1 => 949786183724961807, 50 => 949786369180508163, 99 => 949786173562564612) 1772747461.686 sable_history #x1B[2m2027-03-05T21:52:56.600379Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786620842942468)), timestamp: 1804283576, clock: EventClock(1 => 949786183724961807, 50 => 949786369180508163, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:37225. Last error: I/O error: Connection refused (os error 111) 1772747461.686 sable_history #x1B[2m2027-03-05T21:52:56.601142Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786620842942468)), timestamp: 1804283576, clock: EventClock(1 => 949786183724961807, 50 => 949786369180508163, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1772747461.686 sable_history #x1B[2m2027-03-05T21:52:56.601920Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111) 1772747461.686 sable_history #x1B[2m2027-03-05T21:52:56.602815Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786620842942468)), timestamp: 1804283576, clock: EventClock(1 => 949786183724961807, 50 => 949786369180508163, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:44627. Last error: I/O error: Connection refused (os error 111) 1772747461.686 sable_history #x1B[2m2027-03-05T21:52:56.603938Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(50), 1804283453), content: NewEvent(Event { id: EventId(Snowflake(949786620842942468)), timestamp: 1804283576, clock: EventClock(1 => 949786183724961807, 50 => 949786369180508163, 99 => 949786173562564612), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1772747461.686 sable_history #x1B[2m2027-03-05T21:52:56.604850Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error sending network event: I/O error: Connection refused (os error 111) 1772747463.015 sable_ircd #x1B[2m2027-03-05T21:52:55.191810Z#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(949786614970716170)), timestamp: 1804283575, clock: EventClock(1 => 949786363308281865, 99 => 949786369583362051), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283575 }) }; event clock=EventClock(1 => 949786363308281865, 99 => 949786369583362051) my clock=EventClock(1 => 949786363308281865, 99 => 949786369583362051) 1772747463.016 sable_ircd #x1B[2m2027-03-05T21:52:55.198319Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786614970716170)), timestamp: 1804283575, clock: EventClock(1 => 949786363308281865, 99 => 949786369583362051), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283575 }) }) } #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:59809 (127.0.0.1:59809) 1772747463.016 sable_ircd #x1B[2m2027-03-05T21:52:55.205622Z#x1B[0m #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 1772747463.018 sable_ircd #x1B[2m2027-03-05T21:52:55.230287Z#x1B[0m #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(949786614970716170)), timestamp: 1804283575, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747463.018 sable_ircd #x1B[2m2027-03-05T21:52:55.231157Z#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(949786614970716170)), timestamp: 1804283575, change: EventComplete(EventComplete), users_to_notify: [] } 1772747463.059 sable_services #x1B[2m2027-03-05T21:52:55.843315Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786614970716170)), timestamp: 1804283575, clock: EventClock(1 => 949786363308281865, 99 => 949786369583362051), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283575 }) }) } }#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(949786614970716170)), timestamp: 1804283575, clock: EventClock(1 => 949786363308281865, 99 => 949786369583362051), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283575 }) }; event clock=EventClock(1 => 949786363308281865, 99 => 949786369583362051) my clock=EventClock(1 => 949786363308281865, 99 => 949786369583362051) 1772747463.059 sable_services #x1B[2m2027-03-05T21:52:55.849154Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786614970716170)), timestamp: 1804283575, clock: EventClock(1 => 949786363308281865, 99 => 949786369583362051), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283575 }) }) } }#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786614970716170)), timestamp: 1804283575, clock: EventClock(1 => 949786363308281865, 99 => 949786369583362051), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1804283575 }) }) } #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:51511 (127.0.0.1:51511) 1772747463.115 sable_services #x1B[2m2027-03-05T21:52:56.686118Z#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(949786621237407748)), timestamp: 1804283576, clock: EventClock(1 => 949786614970716170, 99 => 949786369583362051), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283576 }) }; event clock=EventClock(1 => 949786614970716170, 99 => 949786369583362051) my clock=EventClock(1 => 949786614970716170, 99 => 949786369583362051) 1772747463.115 sable_services #x1B[2m2027-03-05T21:52:56.691719Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786621237407748)), timestamp: 1804283576, clock: EventClock(1 => 949786614970716170, 99 => 949786369583362051), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } #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:51511 (127.0.0.1:51511) 1772747463.159 sable_ircd #x1B[2m2027-03-05T21:52:57.346430Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786621237407748)), timestamp: 1804283576, clock: EventClock(1 => 949786614970716170, 99 => 949786369583362051), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } }#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(949786621237407748)), timestamp: 1804283576, clock: EventClock(1 => 949786614970716170, 99 => 949786369583362051), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283576 }) }; event clock=EventClock(1 => 949786614970716170, 99 => 949786369583362051) my clock=EventClock(1 => 949786614970716170, 99 => 949786369583362051) 1772747463.160 sable_ircd #x1B[2m2027-03-05T21:52:57.355037Z#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786621237407748)), timestamp: 1804283576, clock: EventClock(1 => 949786614970716170, 99 => 949786369583362051), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } }#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), 1804283455), content: NewEvent(Event { id: EventId(Snowflake(949786621237407748)), timestamp: 1804283576, clock: EventClock(1 => 949786614970716170, 99 => 949786369583362051), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1804283576 }) }) } #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:59809 (127.0.0.1:59809) 1772747463.162 sable_ircd #x1B[2m2027-03-05T21:52:57.386394Z#x1B[0m #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(949786621237407748)), timestamp: 1804283576, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747463.162 sable_ircd #x1B[2m2027-03-05T21:52:57.387137Z#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(949786621237407748)), timestamp: 1804283576, change: EventComplete(EventComplete), users_to_notify: [] } 1772747464.583 1 -> S: CHATHISTORY LATEST #chanbd556588e2cf82fa7099f810 * 10 1772747464.584 sable_ircd #x1B[2m2027-03-05T21:53:18.722062Z#x1B[0m #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 1772747464.584 sable_ircd #x1B[2m2027-03-05T21:53:18.723174Z#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"CHATHISTORY LATEST #chanbd556588e2cf82fa7099f810 * 10" 1772747464.584 sable_ircd #x1B[2m2027-03-05T21:53:18.729127Z#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): BATCH +72e94bc3d9d24f161f5ac7da7a51e4a chathistory #chanbd556588e2cf82fa7099f810 1772747464.584 sable_ircd #x1B[2m2027-03-05T21:53:18.729821Z#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): BATCH -72e94bc3d9d24f161f5ac7da7a51e4a 1772747464.584 sable_ircd #x1B[2m2027-03-05T21:53:18.730281Z#x1B[0m #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 1772747464.684 1 -> S: PING synchronize302.020172388 1772747464.684 S -> 1: BATCH +72e94bc3d9d24f161f5ac7da7a51e4a chathistory #chanbd556588e2cf82fa7099f810 1772747464.684 S -> 1: BATCH -72e94bc3d9d24f161f5ac7da7a51e4a 1772747464.684 sable_ircd #x1B[2m2027-03-05T21:53:20.225604Z#x1B[0m #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 1772747464.684 sable_ircd #x1B[2m2027-03-05T21:53:20.226740Z#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 synchronize302.020172388" 1772747464.684 sable_ircd #x1B[2m2027-03-05T21:53:20.229389Z#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 :synchronize302.020172388 1772747464.685 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize302.020172388 1772747464.687 sable_ircd #x1B[2m2027-03-05T21:53:20.269808Z#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:51511, peer: 127.0.0.1:57661, fd: 21 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x55b584efcd90, 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 1772747464.690 1: disconnects from server.