--------------------------------- Captured Out ---------------------------------
---- new test ----
1786476531.124 sable_ircd     uid=1001
1786476531.128 sable_ircd     #x1B[2m2026-08-11T19:28:51.127681Z#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(875098458824904704)), timestamp: 1786476531, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476531, name: ServerName("My.Little.Server"), ts: 1786476531, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1786476531.128 sable_ircd     #x1B[2m2026-08-11T19:28:51.127806Z#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
1786476531.128 sable_ircd     #x1B[2m2026-08-11T19:28:51.128061Z#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(875098458824904704)), timestamp: 1786476531, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476531, name: ServerName("My.Little.Server"), ts: 1786476531, 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
1786476531.128 sable_ircd     #x1B[2m2026-08-11T19:28:51.128424Z#x1B[0m #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(875098458824904704)), timestamp: 1786476531, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1786476531.129 sable_ircd     #x1B[2m2026-08-11T19:28:51.128431Z#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(875098458829099009)), timestamp: 1786476531, clock: EventClock(1 => 875098458824904704), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1786476531 }) }; event clock=EventClock(1 => 875098458824904704) my clock=EventClock(1 => 875098458824904704)
1786476531.129 sable_ircd     #x1B[2m2026-08-11T19:28:51.128543Z#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(875098458824904704)), timestamp: 1786476531, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1786476531.129 sable_ircd     #x1B[2m2026-08-11T19:28:51.128603Z#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
1786476531.129 sable_ircd     #x1B[2m2026-08-11T19:28:51.128674Z#x1B[0m #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(875098458824904704)), timestamp: 1786476531, change: EventComplete(EventComplete), users_to_notify: [] })
1786476531.129 sable_ircd     #x1B[2m2026-08-11T19:28:51.128720Z#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(875098458824904704)), timestamp: 1786476531, change: EventComplete(EventComplete), users_to_notify: [] }
1786476531.129 sable_ircd     #x1B[2m2026-08-11T19:28:51.128790Z#x1B[0m #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
1786476531.129 sable_ircd     #x1B[2m2026-08-11T19:28:51.128831Z#x1B[0m #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(875098458829099009)), timestamp: 1786476531, change: EventComplete(EventComplete), users_to_notify: [] })
1786476531.129 sable_ircd     #x1B[2m2026-08-11T19:28:51.128848Z#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(875098458829099009)), timestamp: 1786476531, change: EventComplete(EventComplete), users_to_notify: [] }
1786476531.220 sable_ircd     #x1B[2m2026-08-11T19:28:51.220244Z#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 }
1786476531.220 sable_ircd     #x1B[2m2026-08-11T19:28:51.220389Z#x1B[0m #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
1786476531.220 sable_ircd     #x1B[2m2026-08-11T19:28:51.220449Z#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
1786476531.221 sable_ircd     #x1B[2m2026-08-11T19:28:51.220567Z#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
1786476531.221 sable_ircd     #x1B[2m2026-08-11T19:28:51.220736Z#x1B[0m #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
1786476531.221 sable_ircd     #x1B[2m2026-08-11T19:28:51.220807Z#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"
1786476531.221 sable_ircd     #x1B[2m2026-08-11T19:28:51.220930Z#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
1786476531.221 sable_ircd     #x1B[2m2026-08-11T19:28:51.221048Z#x1B[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))
1786476531.221 sable_ircd     #x1B[2m2026-08-11T19:28:51.221092Z#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)
1786476531.222 sable_ircd     #x1B[2m2026-08-11T19:28:51.221537Z#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
1786476531.222 sable_ircd     #x1B[2m2026-08-11T19:28:51.221649Z#x1B[0m #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
1786476531.222 sable_ircd     #x1B[2m2026-08-11T19:28:51.221883Z#x1B[0m #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
1786476531.241 1: connects to server.
1786476531.241 1 -> S: NICK foo
1786476531.241 1 -> S: USER username * * :Realname
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.241519Z#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 }
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.241684Z#x1B[0m #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
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.241731Z#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
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.241779Z#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
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.241921Z#x1B[0m #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
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.241984Z#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 foo"
1786476531.242 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.242176Z#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: 308, tv_nsec: 302265141 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("foo")), realname: OnceLock(<uninit>), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.242257Z#x1B[0m #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
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.242321Z#x1B[0m #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
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.242359Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER username * * :Realname"
1786476531.242 sable_ircd     #x1B[2m2026-08-11T19:28:51.242437Z#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: 308, tv_nsec: 302265141 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("foo")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1786476531.243 sable_ircd     #x1B[2m2026-08-11T19:28:51.242948Z#x1B[0m #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
1786476531.243 sable_ircd     #x1B[2m2026-08-11T19:28:51.242988Z#x1B[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"))
1786476531.243 sable_ircd     #x1B[2m2026-08-11T19:28:51.243016Z#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
1786476531.243 sable_ircd     #x1B[2m2026-08-11T19:28:51.243037Z#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: 308, tv_nsec: 302265141 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("foo")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1786476531.243 sable_ircd     #x1B[2m2026-08-11T19:28:51.243081Z#x1B[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))
1786476531.243 sable_ircd     #x1B[2m2026-08-11T19:28:51.243321Z#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(875098459311443970)), timestamp: 1786476531, clock: EventClock(1 => 875098458829099009), target: User(UserId(Snowflake(875098459311443968))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(875098459311443969)), NewUserConnection { user: UserId(Snowflake(875098459311443968)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1786476531 })) }) }; event clock=EventClock(1 => 875098458829099009) my clock=EventClock(1 => 875098458829099009)
1786476531.243 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.243452Z#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
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.243744Z#x1B[0m #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(875098459311443970)), timestamp: 1786476531, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098459311443968)), 1) }), users_to_notify: [] })
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.243796Z#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(875098459311443970)), timestamp: 1786476531, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098459311443968)), 1) }), users_to_notify: [] }
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.243847Z#x1B[0m #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(875098459311443970)), timestamp: 1786476531, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098459311443968)), 2), connection: UserConnectionId(Snowflake(875098459311443969)) }), users_to_notify: [] })
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.243871Z#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(875098459311443970)), timestamp: 1786476531, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098459311443968)), 2), connection: UserConnectionId(Snowflake(875098459311443969)) }), users_to_notify: [] }
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.243915Z#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 foo :Welcome to the test Internet Relay Chat network, foo
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.243941Z#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 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.243965Z#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 foo :This server was created 2026-08-11 19:28:51.243955888 UTC
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.243982Z#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 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.244010Z#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 foo EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.244029Z#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 foo :MOTD File is missing
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.244045Z#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): :foo!username@localhost MODE foo +
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.244061Z#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 foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.244085Z#x1B[0m #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(875098459311443970)), timestamp: 1786476531, change: EventComplete(EventComplete), users_to_notify: [] })
1786476531.244 sable_ircd     #x1B[2m2026-08-11T19:28:51.244105Z#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(875098459311443970)), timestamp: 1786476531, change: EventComplete(EventComplete), users_to_notify: [] }
1786476531.244 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo
1786476531.244 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476531.245 S -> 1: :My.Little.Server 003 foo :This server was created 2026-08-11 19:28:51.243955888 UTC
1786476531.245 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476531.245 S -> 1: :My.Little.Server 005 foo EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1786476531.245 S -> 1: :My.Little.Server 422 foo :MOTD File is missing
1786476531.245 S -> 1: :foo!username@localhost MODE foo +
1786476531.245 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476531.245 1 -> S: PING foo
1786476531.245 sable_ircd     #x1B[2m2026-08-11T19:28:51.244904Z#x1B[0m #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
1786476531.245 sable_ircd     #x1B[2m2026-08-11T19:28:51.244955Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING foo"
1786476531.245 sable_ircd     #x1B[2m2026-08-11T19:28:51.245049Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :foo
1786476531.864 sable_history  #x1B[2m2027-08-11T20:11:51.132092Z#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(1007380851090202674)), timestamp: 1818015111, clock: EventClock(1 => 1007370015864786977, 50 => 1007380599440351281, 99 => 1007370023867920389), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015111 }) }; event clock=EventClock(1 => 1007370015864786977, 50 => 1007380599440351281, 99 => 1007370023867920389) my clock=EventClock(1 => 1007370015864786977, 50 => 1007380599440351281, 99 => 1007370023867920389)
1786476531.864 sable_history  #x1B[2m2027-08-11T20:11:51.133597Z#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
1786476532.046 1 -> S: PING synchronize309.106296656
1786476532.046 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1786476532.047 sable_ircd     #x1B[2m2026-08-11T19:28:52.046486Z#x1B[0m #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
1786476532.047 sable_ircd     #x1B[2m2026-08-11T19:28:52.046597Z#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 synchronize309.106296656"
1786476532.047 sable_ircd     #x1B[2m2026-08-11T19:28:52.046782Z#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 :synchronize309.106296656
1786476532.047 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize309.106296656
1786476532.047 2: connects to server.
1786476532.047 2 -> S: NICK bar
1786476532.047 2 -> S: USER username * * :Realname
1786476532.048 sable_ircd     #x1B[2m2026-08-11T19:28:52.047686Z#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 }
1786476532.048 sable_ircd     #x1B[2m2026-08-11T19:28:52.047836Z#x1B[0m #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
1786476532.048 sable_ircd     #x1B[2m2026-08-11T19:28:52.047878Z#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
1786476532.048 sable_ircd     #x1B[2m2026-08-11T19:28:52.047938Z#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
1786476532.048 sable_ircd     #x1B[2m2026-08-11T19:28:52.048069Z#x1B[0m #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
1786476532.048 sable_ircd     #x1B[2m2026-08-11T19:28:52.048134Z#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"
1786476532.048 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname
1786476532.048 sable_ircd     #x1B[2m2026-08-11T19:28:52.048280Z#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: 309, tv_nsec: 108415134 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("bar")), realname: OnceLock(<uninit>), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1786476532.048 sable_ircd     #x1B[2m2026-08-11T19:28:52.048365Z#x1B[0m #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
1786476532.048 sable_ircd     #x1B[2m2026-08-11T19:28:52.048444Z#x1B[0m #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
1786476532.049 sable_ircd     #x1B[2m2026-08-11T19:28:52.048492Z#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"
1786476532.049 sable_ircd     #x1B[2m2026-08-11T19:28:52.048624Z#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: 309, tv_nsec: 108415134 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("bar")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1786476532.049 sable_ircd     #x1B[2m2026-08-11T19:28:52.049246Z#x1B[0m #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
1786476532.049 sable_ircd     #x1B[2m2026-08-11T19:28:52.049277Z#x1B[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"))
1786476532.049 sable_ircd     #x1B[2m2026-08-11T19:28:52.049302Z#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
1786476532.049 sable_ircd     #x1B[2m2026-08-11T19:28:52.049324Z#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: 309, tv_nsec: 108415134 }, attach_user_id: OnceLock(<uninit>), 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(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1786476532.049 sable_ircd     #x1B[2m2026-08-11T19:28:52.049373Z#x1B[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))
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.049657Z#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(875098462692052995)), timestamp: 1786476532, clock: EventClock(1 => 875098459311443970), target: User(UserId(Snowflake(875098462692052994))), 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(875098462692052995)), NewUserConnection { user: UserId(Snowflake(875098462692052994)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1786476532 })) }) }; event clock=EventClock(1 => 875098459311443970) my clock=EventClock(1 => 875098459311443970)
1786476532.050 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.049788Z#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
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050125Z#x1B[0m #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(875098462692052995)), timestamp: 1786476532, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098462692052994)), 1) }), users_to_notify: [] })
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050167Z#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(875098462692052995)), timestamp: 1786476532, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098462692052994)), 1) }), users_to_notify: [] }
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050212Z#x1B[0m #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(875098462692052995)), timestamp: 1786476532, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098462692052994)), 2), connection: UserConnectionId(Snowflake(875098462692052995)) }), users_to_notify: [] })
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050235Z#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(875098462692052995)), timestamp: 1786476532, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098462692052994)), 2), connection: UserConnectionId(Snowflake(875098462692052995)) }), users_to_notify: [] }
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050278Z#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
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050304Z#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
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050324Z#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 2026-08-11 19:28:52.050315597 UTC
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050341Z#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
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050359Z#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
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050377Z#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
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050393Z#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 +
1786476532.050 sable_ircd     #x1B[2m2026-08-11T19:28:52.050410Z#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.
1786476532.051 sable_ircd     #x1B[2m2026-08-11T19:28:52.050462Z#x1B[0m #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(875098462692052995)), timestamp: 1786476532, change: EventComplete(EventComplete), users_to_notify: [] })
1786476532.051 sable_ircd     #x1B[2m2026-08-11T19:28:52.050500Z#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(875098462692052995)), timestamp: 1786476532, change: EventComplete(EventComplete), users_to_notify: [] }
1786476532.051 S -> 2: :My.Little.Server 001 bar :Welcome to the test Internet Relay Chat network, bar
1786476532.051 S -> 2: :My.Little.Server 002 bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476532.051 2 -> S: PING foo
1786476532.052 sable_ircd     #x1B[2m2026-08-11T19:28:52.051852Z#x1B[0m #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
1786476532.052 sable_ircd     #x1B[2m2026-08-11T19:28:52.051900Z#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"
1786476532.052 sable_ircd     #x1B[2m2026-08-11T19:28:52.051987Z#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
1786476532.060 sable_history  #x1B[2m2027-08-11T20:09:02.835882Z#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(1007380145205616686)), timestamp: 1818014942, clock: EventClock(1 => 1007369312341594113, 50 => 1007379893547376685), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014942 }) }; event clock=EventClock(1 => 1007369312341594113, 50 => 1007379893547376685) my clock=EventClock(1 => 1007369312341594113, 50 => 1007379893547376685)
1786476532.060 sable_history  #x1B[2m2027-08-11T20:09:02.838121Z#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
1786476532.251 2 -> S: PING synchronize309.311673143
1786476532.251 S -> 2: :My.Little.Server 003 bar :This server was created 2026-08-11 19:28:52.050315597 UTC
1786476532.251 S -> 2: :My.Little.Server 004 bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476532.251 S -> 2: :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
1786476532.251 S -> 2: :My.Little.Server 422 bar :MOTD File is missing
1786476532.251 S -> 2: :bar!username@localhost MODE bar +
1786476532.252 S -> 2: :My.Little.Server NOTICE bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476532.252 S -> 2: :My.Little.Server PONG My.Little.Server :foo
1786476532.252 sable_ircd     #x1B[2m2026-08-11T19:28:52.251800Z#x1B[0m #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
1786476532.252 sable_ircd     #x1B[2m2026-08-11T19:28:52.251868Z#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 synchronize309.311673143"
1786476532.252 sable_ircd     #x1B[2m2026-08-11T19:28:52.252005Z#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 :synchronize309.311673143
1786476532.252 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize309.311673143
1786476532.560 sable_history  #x1B[2m2027-08-11T20:09:03.442304Z#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(1007380147747364910)), timestamp: 1818014943, clock: EventClock(1 => 1007369314333888513, 50 => 1007379896093319213), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014943 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007379896093319213) my clock=EventClock(1 => 1007369314333888513, 50 => 1007379896093319213)
1786476532.560 sable_history  #x1B[2m2027-08-11T20:09:03.444488Z#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
1786476532.876 sable_history  #x1B[2m2027-08-11T20:14:39.718434Z#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(1007381558191136821)), timestamp: 1818015279, clock: EventClock(1 => 1007369718299889686, 50 => 1007381306524508212, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015279 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007381306524508212, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007381306524508212, 99 => 1007369721508933636)
1786476532.876 sable_history  #x1B[2m2027-08-11T20:14:39.720381Z#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
1786476532.954 1 -> S: PING synchronize310.013936077
1786476532.954 sable_ircd     #x1B[2m2026-08-11T19:28:52.954141Z#x1B[0m #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
1786476532.954 sable_ircd     #x1B[2m2026-08-11T19:28:52.954209Z#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 synchronize310.013936077"
1786476532.954 sable_ircd     #x1B[2m2026-08-11T19:28:52.954354Z#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 :synchronize310.013936077
1786476532.955 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize310.013936077
1786476533.041 sable_history  #x1B[2m2027-08-11T20:09:03.811588Z#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(1007380149295063086)), timestamp: 1818014943, clock: EventClock(1 => 1007369316242296833, 50 => 1007379897636823085), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014943 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007379897636823085) my clock=EventClock(1 => 1007369316242296833, 50 => 1007379897636823085)
1786476533.041 sable_history  #x1B[2m2027-08-11T20:09:03.813888Z#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
1786476533.055 2 -> S: PING synchronize310.115336004
1786476533.055 sable_ircd     #x1B[2m2026-08-11T19:28:53.055315Z#x1B[0m #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
1786476533.055 sable_ircd     #x1B[2m2026-08-11T19:28:53.055372Z#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 synchronize310.115336004"
1786476533.056 sable_ircd     #x1B[2m2026-08-11T19:28:53.055534Z#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 :synchronize310.115336004
1786476533.056 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize310.115336004
1786476533.056 1 -> S: JOIN #chan
1786476533.056 sable_ircd     #x1B[2m2026-08-11T19:28:53.056201Z#x1B[0m #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
1786476533.056 sable_ircd     #x1B[2m2026-08-11T19:28:53.056240Z#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"JOIN #chan"
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.056467Z#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(875098466915717124)), timestamp: 1786476533, clock: EventClock(1 => 875098462692052995), target: Channel(ChannelId(Snowflake(875098466915717124))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 875098462692052995) my clock=EventClock(1 => 875098462692052995)
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.056648Z#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
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.056758Z#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(875098466915717125)), timestamp: 1786476533, clock: EventClock(1 => 875098466915717124), target: Membership(MembershipId(UserId(Snowflake(875098459311443968)), ChannelId(Snowflake(875098466915717124)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(875098466915717124)), user: UserId(Snowflake(875098459311443968)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 875098466915717124) my clock=EventClock(1 => 875098466915717124)
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.056900Z#x1B[0m #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
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.056956Z#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
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.057189Z#x1B[0m #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(875098466915717124)), timestamp: 1786476533, change: EventComplete(EventComplete), users_to_notify: [] })
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.057231Z#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(875098466915717124)), timestamp: 1786476533, change: EventComplete(EventComplete), users_to_notify: [] }
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.057293Z#x1B[0m #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(875098466915717125)), timestamp: 1786476533, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(875098459311443968)), ChannelId(Snowflake(875098466915717124))), user: HistoricUserId(UserId(Snowflake(875098459311443968)), 2) }), users_to_notify: [UserId(Snowflake(875098459311443968))] })
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.057332Z#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(875098466915717125)), timestamp: 1786476533, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(875098459311443968)), ChannelId(Snowflake(875098466915717124))), user: HistoricUserId(UserId(Snowflake(875098459311443968)), 2) }), users_to_notify: [UserId(Snowflake(875098459311443968))] }
1786476533.057 sable_ircd     #x1B[2m2026-08-11T19:28:53.057409Z#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): :foo!username@localhost JOIN #chan
1786476533.058 sable_ircd     #x1B[2m2026-08-11T19:28:53.057466Z#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): :foo!username@localhost MODE #chan +o foo
1786476533.058 sable_ircd     #x1B[2m2026-08-11T19:28:53.057566Z#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 353 foo = #chan :@foo
1786476533.058 sable_ircd     #x1B[2m2026-08-11T19:28:53.057608Z#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 366 foo #chan :End of names list
1786476533.058 sable_ircd     #x1B[2m2026-08-11T19:28:53.057661Z#x1B[0m #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(875098466915717125)), timestamp: 1786476533, change: EventComplete(EventComplete), users_to_notify: [] })
1786476533.058 sable_ircd     #x1B[2m2026-08-11T19:28:53.057697Z#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(875098466915717125)), timestamp: 1786476533, change: EventComplete(EventComplete), users_to_notify: [] }
1786476533.156 1 -> S: PING synchronize310.216561904
1786476533.156 S -> 1: :foo!username@localhost JOIN #chan
1786476533.156 S -> 1: :foo!username@localhost MODE #chan +o foo
1786476533.156 S -> 1: :My.Little.Server 353 foo = #chan :@foo
1786476533.156 S -> 1: :My.Little.Server 366 foo #chan :End of names list
1786476533.157 sable_ircd     #x1B[2m2026-08-11T19:28:53.156646Z#x1B[0m #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
1786476533.157 sable_ircd     #x1B[2m2026-08-11T19:28:53.156708Z#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 synchronize310.216561904"
1786476533.536 sable_history  #x1B[2m2027-08-11T20:17:28.354252Z#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(1007382265501786168)), timestamp: 1818015448, clock: EventClock(1 => 1007369670753259542, 50 => 1007382013847740471, 99 => 1007369673970692100), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015448 }) }; event clock=EventClock(1 => 1007369670753259542, 50 => 1007382013847740471, 99 => 1007369673970692100) my clock=EventClock(1 => 1007369670753259542, 50 => 1007382013847740471, 99 => 1007369673970692100)
1786476533.536 sable_history  #x1B[2m2027-08-11T20:17:28.355833Z#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
1786476533.549 sable_history  #x1B[2m2027-08-11T20:09:04.565746Z#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(1007380152461762606)), timestamp: 1818014944, clock: EventClock(1 => 1007369318356226049, 50 => 1007379900803522605), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014944 }) }; event clock=EventClock(1 => 1007369318356226049, 50 => 1007379900803522605) my clock=EventClock(1 => 1007369318356226049, 50 => 1007379900803522605)
1786476533.549 sable_history  #x1B[2m2027-08-11T20:09:04.567545Z#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
1786476534.059 sable_history  #x1B[2m2027-08-11T20:09:05.940933Z#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(1007380158224736303)), timestamp: 1818014945, clock: EventClock(1 => 1007369320184942593, 50 => 1007379906566496302, 99 => 1007369323750502402), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014945 }) }; event clock=EventClock(1 => 1007369320184942593, 50 => 1007379906566496302, 99 => 1007369323750502402) my clock=EventClock(1 => 1007369320184942593, 50 => 1007379906566496302, 99 => 1007369323750502402)
1786476534.059 sable_history  #x1B[2m2027-08-11T20:09:05.942694Z#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
1786476534.157 1: waiting…
1786476534.162 sable_ircd     #x1B[2m2026-08-11T19:28:54.162352Z#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 :synchronize310.216561904
1786476534.163 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize310.216561904
1786476534.163 1 -> S: MODE #chan +i
1786476534.164 sable_ircd     #x1B[2m2026-08-11T19:28:54.163915Z#x1B[0m #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
1786476534.164 sable_ircd     #x1B[2m2026-08-11T19:28:54.163975Z#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"MODE #chan +i"
1786476534.264 1 -> S: PING synchronize311.324037857
1786476534.264 sable_ircd     #x1B[2m2026-08-11T19:28:54.263958Z#x1B[0m #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
1786476534.264 sable_ircd     #x1B[2m2026-08-11T19:28:54.264021Z#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 synchronize311.324037857"
1786476534.436 sable_history  #x1B[2m2027-08-11T20:20:25.928551Z#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(1007383010301124667)), timestamp: 1818015625, clock: EventClock(1 => 1007369621558267926, 50 => 1007382758756130874, 99 => 1007369624859586564), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015625 }) }; event clock=EventClock(1 => 1007369621558267926, 50 => 1007382758756130874, 99 => 1007369624859586564) my clock=EventClock(1 => 1007369621558267926, 50 => 1007382758756130874, 99 => 1007369624859586564)
1786476534.436 sable_history  #x1B[2m2027-08-11T20:20:25.930031Z#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
1786476534.479 sable_history  #x1B[2m2027-08-11T20:09:05.417805Z#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(1007380156035309615)), timestamp: 1818014945, clock: EventClock(1 => 1007369401122426895, 50 => 1007379904385458222, 99 => 1007369391161356292), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014945 }) }; event clock=EventClock(1 => 1007369401122426895, 50 => 1007379904385458222, 99 => 1007369391161356292) my clock=EventClock(1 => 1007369401122426895, 50 => 1007379904385458222, 99 => 1007369391161356292)
1786476534.479 sable_history  #x1B[2m2027-08-11T20:09:05.419193Z#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
1786476535.018 sable_ircd     #x1B[2m2026-08-11T19:28:55.018216Z#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(875098475144941574)), timestamp: 1786476535, clock: EventClock(1 => 875098466915717125), target: Channel(ChannelId(Snowflake(875098466915717124))), details: ChannelModeChange(ChannelModeChange { changed_by: User(UserId(Snowflake(875098459311443968))), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange }) }; event clock=EventClock(1 => 875098466915717125) my clock=EventClock(1 => 875098466915717125)
1786476535.019 sable_ircd     #x1B[2m2026-08-11T19:28:55.018448Z#x1B[0m #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
1786476535.019 sable_ircd     #x1B[2m2026-08-11T19:28:55.018474Z#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
1786476535.019 sable_ircd     #x1B[2m2026-08-11T19:28:55.018807Z#x1B[0m #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(875098475144941574)), timestamp: 1786476535, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(875098466915717124)), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(875098459311443968)), 2)) }), users_to_notify: [UserId(Snowflake(875098459311443968))] })
1786476535.019 sable_ircd     #x1B[2m2026-08-11T19:28:55.018861Z#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(875098475144941574)), timestamp: 1786476535, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(875098466915717124)), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(875098459311443968)), 2)) }), users_to_notify: [UserId(Snowflake(875098459311443968))] }
1786476535.019 sable_ircd     #x1B[2m2026-08-11T19:28:55.018951Z#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): :foo!username@localhost MODE #chan +i
1786476535.019 sable_ircd     #x1B[2m2026-08-11T19:28:55.019028Z#x1B[0m #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(875098475144941574)), timestamp: 1786476535, change: EventComplete(EventComplete), users_to_notify: [] })
1786476535.019 sable_ircd     #x1B[2m2026-08-11T19:28:55.019066Z#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(875098475144941574)), timestamp: 1786476535, change: EventComplete(EventComplete), users_to_notify: [] }
1786476535.019 S -> 1: :foo!username@localhost MODE #chan +i
1786476535.864 sable_history  #x1B[2m2027-08-11T20:12:51.133353Z#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(1007381102752636979)), timestamp: 1818015171, clock: EventClock(1 => 1007370015864786977, 50 => 1007380851090202674, 99 => 1007370023867920389), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015171 }) }; event clock=EventClock(1 => 1007370015864786977, 50 => 1007380851090202674, 99 => 1007370023867920389) my clock=EventClock(1 => 1007370015864786977, 50 => 1007380851090202674, 99 => 1007370023867920389)
1786476535.865 sable_history  #x1B[2m2027-08-11T20:12:51.135220Z#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
1786476536.021 1: waiting…
1786476536.025 sable_ircd     #x1B[2m2026-08-11T19:28:56.024790Z#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 :synchronize311.324037857
1786476536.025 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize311.324037857
1786476536.025 1 -> S: INVITE bar #chan
1786476536.026 sable_ircd     #x1B[2m2026-08-11T19:28:56.025806Z#x1B[0m #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
1786476536.026 sable_ircd     #x1B[2m2026-08-11T19:28:56.025853Z#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"INVITE bar #chan"
1786476536.060 sable_history  #x1B[2m2027-08-11T20:10:02.835862Z#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(1007380396863856687)), timestamp: 1818015002, clock: EventClock(1 => 1007369312341594113, 50 => 1007380145205616686), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015002 }) }; event clock=EventClock(1 => 1007369312341594113, 50 => 1007380145205616686) my clock=EventClock(1 => 1007369312341594113, 50 => 1007380145205616686)
1786476536.060 sable_history  #x1B[2m2027-08-11T20:10:02.837956Z#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
1786476536.126 1 -> S: PING synchronize313.186108143
1786476536.126 sable_ircd     #x1B[2m2026-08-11T19:28:56.126150Z#x1B[0m #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
1786476536.126 sable_ircd     #x1B[2m2026-08-11T19:28:56.126205Z#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 synchronize313.186108143"
1786476536.560 sable_history  #x1B[2m2027-08-11T20:10:03.442473Z#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(1007380399405604911)), timestamp: 1818015003, clock: EventClock(1 => 1007369314333888513, 50 => 1007380147747364910), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015003 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007380147747364910) my clock=EventClock(1 => 1007369314333888513, 50 => 1007380147747364910)
1786476536.560 sable_history  #x1B[2m2027-08-11T20:10:03.444450Z#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
1786476536.876 sable_history  #x1B[2m2027-08-11T20:15:39.717979Z#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(1007381809849376822)), timestamp: 1818015339, clock: EventClock(1 => 1007369718299889686, 50 => 1007381558191136821, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015339 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007381558191136821, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007381558191136821, 99 => 1007369721508933636)
1786476536.876 sable_history  #x1B[2m2027-08-11T20:15:39.719898Z#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
1786476537.041 sable_history  #x1B[2m2027-08-11T20:10:03.812188Z#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(1007380400957497391)), timestamp: 1818015003, clock: EventClock(1 => 1007369316242296833, 50 => 1007380149295063086), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015003 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007380149295063086) my clock=EventClock(1 => 1007369316242296833, 50 => 1007380149295063086)
1786476537.041 sable_history  #x1B[2m2027-08-11T20:10:03.814694Z#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
1786476537.127 1: waiting…
1786476537.132 sable_ircd     #x1B[2m2026-08-11T19:28:57.131777Z#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 341 foo bar #chan
1786476537.132 sable_ircd     #x1B[2m2026-08-11T19:28:57.131838Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mStateChange(Invite(InviteId(UserId(Snowflake(875098462692052994)), ChannelId(Snowflake(875098466915717124)))), ChannelInvite(ChannelInvite { source: UserId(Snowflake(875098459311443968)) }))
1786476537.132 sable_ircd     #x1B[2m2026-08-11T19:28:57.131994Z#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(875098484007505927)), timestamp: 1786476537, clock: EventClock(1 => 875098475144941574), target: Invite(InviteId(UserId(Snowflake(875098462692052994)), ChannelId(Snowflake(875098466915717124)))), details: ChannelInvite(ChannelInvite { source: UserId(Snowflake(875098459311443968)) }) }; event clock=EventClock(1 => 875098475144941574) my clock=EventClock(1 => 875098475144941574)
1786476537.132 sable_ircd     #x1B[2m2026-08-11T19:28:57.132079Z#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
1786476537.132 S -> 1: :My.Little.Server 341 foo bar #chan
1786476537.132 sable_ircd     #x1B[2m2026-08-11T19:28:57.132366Z#x1B[0m #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(875098484007505927)), timestamp: 1786476537, change: ChannelInvite(ChannelInvite { invite: InviteId(UserId(Snowflake(875098462692052994)), ChannelId(Snowflake(875098466915717124))), source: User(HistoricUserId(UserId(Snowflake(875098459311443968)), 2)), user: HistoricUserId(UserId(Snowflake(875098462692052994)), 2) }), users_to_notify: [UserId(Snowflake(875098462692052994))] })
1786476537.132 sable_ircd     #x1B[2m2026-08-11T19:28:57.132409Z#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(875098484007505927)), timestamp: 1786476537, change: ChannelInvite(ChannelInvite { invite: InviteId(UserId(Snowflake(875098462692052994)), ChannelId(Snowflake(875098466915717124))), source: User(HistoricUserId(UserId(Snowflake(875098459311443968)), 2)), user: HistoricUserId(UserId(Snowflake(875098462692052994)), 2) }), users_to_notify: [UserId(Snowflake(875098462692052994))] }
1786476537.133 sable_ircd     #x1B[2m2026-08-11T19:28:57.132481Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :foo!username@localhost INVITE bar :#chan
1786476537.133 sable_ircd     #x1B[2m2026-08-11T19:28:57.132593Z#x1B[0m #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(875098484007505927)), timestamp: 1786476537, change: EventComplete(EventComplete), users_to_notify: [] })
1786476537.133 sable_ircd     #x1B[2m2026-08-11T19:28:57.132637Z#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(875098484007505927)), timestamp: 1786476537, change: EventComplete(EventComplete), users_to_notify: [] }
1786476537.536 sable_history  #x1B[2m2027-08-11T20:18:28.355203Z#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(1007382517164220473)), timestamp: 1818015508, clock: EventClock(1 => 1007369670753259542, 50 => 1007382265501786168, 99 => 1007369673970692100), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015508 }) }; event clock=EventClock(1 => 1007369670753259542, 50 => 1007382265501786168, 99 => 1007369673970692100) my clock=EventClock(1 => 1007369670753259542, 50 => 1007382265501786168, 99 => 1007369673970692100)
1786476537.536 sable_history  #x1B[2m2027-08-11T20:18:28.357279Z#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
1786476537.549 sable_history  #x1B[2m2027-08-11T20:10:04.566033Z#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(1007380404120002607)), timestamp: 1818015004, clock: EventClock(1 => 1007369318356226049, 50 => 1007380152461762606), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015004 }) }; event clock=EventClock(1 => 1007369318356226049, 50 => 1007380152461762606) my clock=EventClock(1 => 1007369318356226049, 50 => 1007380152461762606)
1786476537.550 sable_history  #x1B[2m2027-08-11T20:10:04.568163Z#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
1786476538.059 sable_history  #x1B[2m2027-08-11T20:10:05.940539Z#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(1007380409882976304)), timestamp: 1818015005, clock: EventClock(1 => 1007369320184942593, 50 => 1007380158224736303, 99 => 1007369323750502402), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015005 }) }; event clock=EventClock(1 => 1007369320184942593, 50 => 1007380158224736303, 99 => 1007369323750502402) my clock=EventClock(1 => 1007369320184942593, 50 => 1007380158224736303, 99 => 1007369323750502402)
1786476538.059 sable_history  #x1B[2m2027-08-11T20:10:05.942583Z#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
1786476538.133 1: waiting…
1786476538.137 sable_ircd     #x1B[2m2026-08-11T19:28:58.137166Z#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 :synchronize313.186108143
1786476538.138 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize313.186108143
1786476538.238 2 -> S: PING synchronize315.298414359
1786476538.238 S -> 2: :foo!username@localhost INVITE bar :#chan
1786476538.239 sable_ircd     #x1B[2m2026-08-11T19:28:58.238450Z#x1B[0m #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
1786476538.239 sable_ircd     #x1B[2m2026-08-11T19:28:58.238562Z#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 synchronize315.298414359"
1786476538.239 sable_ircd     #x1B[2m2026-08-11T19:28:58.238702Z#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 :synchronize315.298414359
1786476538.239 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize315.298414359
1786476538.242 1: disconnects from server.
1786476538.242 2: disconnects from server.