--------------------------------- Captured Out ---------------------------------
---- new test ----
1786476548.283 sable_ircd     uid=1001
1786476548.287 sable_ircd     #x1B[2m2026-08-11T19:29:08.286161Z#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(875098530794967040)), timestamp: 1786476548, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476548, name: ServerName("My.Little.Server"), ts: 1786476548, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1786476548.287 sable_ircd     #x1B[2m2026-08-11T19:29:08.286285Z#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
1786476548.287 sable_ircd     #x1B[2m2026-08-11T19:29:08.286495Z#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(875098530794967040)), timestamp: 1786476548, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476548, name: ServerName("My.Little.Server"), ts: 1786476548, 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
1786476548.287 sable_ircd     #x1B[2m2026-08-11T19:29:08.286655Z#x1B[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(875098530794967040)), timestamp: 1786476548, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1786476548.287 sable_ircd     #x1B[2m2026-08-11T19:29:08.286696Z#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(875098530794967040)), timestamp: 1786476548, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1786476548.287 sable_ircd     #x1B[2m2026-08-11T19:29:08.286745Z#x1B[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(875098530794967040)), timestamp: 1786476548, change: EventComplete(EventComplete), users_to_notify: [] })
1786476548.287 sable_ircd     #x1B[2m2026-08-11T19:29:08.286775Z#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(875098530794967040)), timestamp: 1786476548, change: EventComplete(EventComplete), users_to_notify: [] }
1786476548.288 sable_ircd     #x1B[2m2026-08-11T19:29:08.287479Z#x1B[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
1786476548.288 sable_ircd     #x1B[2m2026-08-11T19:29:08.287765Z#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(875098530799161345)), timestamp: 1786476548, clock: EventClock(1 => 875098530794967040), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1786476548 }) }; event clock=EventClock(1 => 875098530794967040) my clock=EventClock(1 => 875098530794967040)
1786476548.288 sable_ircd     #x1B[2m2026-08-11T19:29:08.287845Z#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
1786476548.288 sable_ircd     #x1B[2m2026-08-11T19:29:08.288071Z#x1B[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(875098530799161345)), timestamp: 1786476548, change: EventComplete(EventComplete), users_to_notify: [] })
1786476548.288 sable_ircd     #x1B[2m2026-08-11T19:29:08.288120Z#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(875098530799161345)), timestamp: 1786476548, change: EventComplete(EventComplete), users_to_notify: [] }
1786476548.379 sable_ircd     #x1B[2m2026-08-11T19:29:08.379009Z#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 }
1786476548.379 sable_ircd     #x1B[2m2026-08-11T19:29:08.379135Z#x1B[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
1786476548.379 sable_ircd     #x1B[2m2026-08-11T19:29:08.379179Z#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
1786476548.379 sable_ircd     #x1B[2m2026-08-11T19:29:08.379245Z#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
1786476548.379 sable_ircd     #x1B[2m2026-08-11T19:29:08.379395Z#x1B[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
1786476548.380 sable_ircd     #x1B[2m2026-08-11T19:29:08.379468Z#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"
1786476548.380 sable_ircd     #x1B[2m2026-08-11T19:29:08.379631Z#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
1786476548.380 sable_ircd     #x1B[2m2026-08-11T19:29:08.379746Z#x1B[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))
1786476548.380 sable_ircd     #x1B[2m2026-08-11T19:29:08.379787Z#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)
1786476548.380 sable_ircd     #x1B[2m2026-08-11T19:29:08.380249Z#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
1786476548.380 sable_ircd     #x1B[2m2026-08-11T19:29:08.380348Z#x1B[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
1786476548.381 sable_ircd     #x1B[2m2026-08-11T19:29:08.380589Z#x1B[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
1786476548.400 1: connects to server.
1786476548.400 1 -> S: NICK foo
1786476548.400 1 -> S: USER username * * :Realname
1786476548.400 sable_ircd     #x1B[2m2026-08-11T19:29:08.400250Z#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 }
1786476548.400 sable_ircd     #x1B[2m2026-08-11T19:29:08.400347Z#x1B[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
1786476548.400 sable_ircd     #x1B[2m2026-08-11T19:29:08.400382Z#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
1786476548.400 sable_ircd     #x1B[2m2026-08-11T19:29:08.400425Z#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
1786476548.401 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1786476548.401 sable_ircd     #x1B[2m2026-08-11T19:29:08.400628Z#x1B[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
1786476548.401 sable_ircd     #x1B[2m2026-08-11T19:29:08.400685Z#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"
1786476548.401 sable_ircd     #x1B[2m2026-08-11T19:29:08.400803Z#x1B[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
1786476548.401 sable_ircd     #x1B[2m2026-08-11T19:29:08.400838Z#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"
1786476548.401 sable_ircd     #x1B[2m2026-08-11T19:29:08.400916Z#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: 325, tv_nsec: 460913859 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(<uninit>), 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
1786476548.401 sable_ircd     #x1B[2m2026-08-11T19:29:08.401001Z#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: 325, tv_nsec: 460913859 }, 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
1786476548.401 sable_ircd     #x1B[2m2026-08-11T19:29:08.401051Z#x1B[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
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.401544Z#x1B[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
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.401584Z#x1B[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"))
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.401624Z#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
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.401647Z#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: 325, tv_nsec: 460913859 }, 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
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.401693Z#x1B[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))
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.401927Z#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(875098531277312002)), timestamp: 1786476548, clock: EventClock(1 => 875098530799161345), target: User(UserId(Snowflake(875098531277312000))), 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(875098531277312001)), NewUserConnection { user: UserId(Snowflake(875098531277312000)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1786476548 })) }) }; event clock=EventClock(1 => 875098530799161345) my clock=EventClock(1 => 875098530799161345)
1786476548.402 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.402037Z#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
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.402359Z#x1B[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(875098531277312002)), timestamp: 1786476548, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098531277312000)), 1) }), users_to_notify: [] })
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.402398Z#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(875098531277312002)), timestamp: 1786476548, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098531277312000)), 1) }), users_to_notify: [] }
1786476548.402 sable_ircd     #x1B[2m2026-08-11T19:29:08.402455Z#x1B[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(875098531277312002)), timestamp: 1786476548, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098531277312000)), 2), connection: UserConnectionId(Snowflake(875098531277312001)) }), users_to_notify: [] })
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402480Z#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(875098531277312002)), timestamp: 1786476548, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098531277312000)), 2), connection: UserConnectionId(Snowflake(875098531277312001)) }), users_to_notify: [] }
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402558Z#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
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402594Z#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
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402618Z#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:29:08.402609548 UTC
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402636Z#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
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402668Z#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
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402688Z#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
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402708Z#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 +
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402724Z#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.
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402774Z#x1B[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(875098531277312002)), timestamp: 1786476548, change: EventComplete(EventComplete), users_to_notify: [] })
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.402799Z#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(875098531277312002)), timestamp: 1786476548, change: EventComplete(EventComplete), users_to_notify: [] }
1786476548.403 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo
1786476548.403 1 -> S: PING foo
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.403304Z#x1B[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
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.403367Z#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"
1786476548.403 sable_ircd     #x1B[2m2026-08-11T19:29:08.403440Z#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
1786476548.503 1 -> S: PING synchronize325.563736713
1786476548.503 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476548.503 S -> 1: :My.Little.Server 003 foo :This server was created 2026-08-11 19:29:08.402609548 UTC
1786476548.503 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476548.503 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
1786476548.503 S -> 1: :My.Little.Server 422 foo :MOTD File is missing
1786476548.503 S -> 1: :foo!username@localhost MODE foo +
1786476548.503 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476548.503 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1786476548.504 sable_ircd     #x1B[2m2026-08-11T19:29:08.503841Z#x1B[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
1786476548.504 sable_ircd     #x1B[2m2026-08-11T19:29:08.503913Z#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 synchronize325.563736713"
1786476548.504 sable_ircd     #x1B[2m2026-08-11T19:29:08.504058Z#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 :synchronize325.563736713
1786476548.504 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize325.563736713
1786476548.560 sable_history  #x1B[2m2027-08-11T20:13:03.442842Z#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(1007381154380324914)), timestamp: 1818015183, clock: EventClock(1 => 1007369314333888513, 50 => 1007380902722084913), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015183 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007380902722084913) my clock=EventClock(1 => 1007369314333888513, 50 => 1007380902722084913)
1786476548.560 sable_history  #x1B[2m2027-08-11T20:13:03.445239Z#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
1786476548.876 sable_history  #x1B[2m2027-08-11T20:18:39.718377Z#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(1007382564824096825)), timestamp: 1818015519, clock: EventClock(1 => 1007369718299889686, 50 => 1007382313161662520, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015519 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007382313161662520, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007382313161662520, 99 => 1007369721508933636)
1786476548.876 sable_history  #x1B[2m2027-08-11T20:18:39.719926Z#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
1786476549.041 sable_history  #x1B[2m2027-08-11T20:13:03.811306Z#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(1007381155928023090)), timestamp: 1818015183, clock: EventClock(1 => 1007369316242296833, 50 => 1007380904269783089), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015183 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007380904269783089) my clock=EventClock(1 => 1007369316242296833, 50 => 1007380904269783089)
1786476549.041 sable_history  #x1B[2m2027-08-11T20:13:03.813665Z#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
1786476549.206 2: connects to server.
1786476549.206 2 -> S: NICK bar
1786476549.206 2 -> S: USER username * * :Realname
1786476549.206 sable_ircd     #x1B[2m2026-08-11T19:29:09.206184Z#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 }
1786476549.206 sable_ircd     #x1B[2m2026-08-11T19:29:09.206315Z#x1B[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
1786476549.206 sable_ircd     #x1B[2m2026-08-11T19:29:09.206362Z#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
1786476549.206 sable_ircd     #x1B[2m2026-08-11T19:29:09.206433Z#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
1786476549.207 sable_ircd     #x1B[2m2026-08-11T19:29:09.206647Z#x1B[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
1786476549.207 sable_ircd     #x1B[2m2026-08-11T19:29:09.206703Z#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"
1786476549.207 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname
1786476549.207 sable_ircd     #x1B[2m2026-08-11T19:29:09.206871Z#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: 326, tv_nsec: 266907958 }, 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
1786476549.207 sable_ircd     #x1B[2m2026-08-11T19:29:09.206931Z#x1B[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
1786476549.207 sable_ircd     #x1B[2m2026-08-11T19:29:09.206979Z#x1B[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
1786476549.207 sable_ircd     #x1B[2m2026-08-11T19:29:09.207011Z#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"
1786476549.207 sable_ircd     #x1B[2m2026-08-11T19:29:09.207081Z#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: 326, tv_nsec: 266907958 }, 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
1786476549.208 sable_ircd     #x1B[2m2026-08-11T19:29:09.207682Z#x1B[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
1786476549.208 sable_ircd     #x1B[2m2026-08-11T19:29:09.207720Z#x1B[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"))
1786476549.208 sable_ircd     #x1B[2m2026-08-11T19:29:09.207759Z#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
1786476549.208 sable_ircd     #x1B[2m2026-08-11T19:29:09.207801Z#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: 326, tv_nsec: 266907958 }, 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
1786476549.208 sable_ircd     #x1B[2m2026-08-11T19:29:09.207870Z#x1B[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))
1786476549.208 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208139Z#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(875098534662115331)), timestamp: 1786476549, clock: EventClock(1 => 875098531277312002), target: User(UserId(Snowflake(875098534657921026))), 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(875098534657921027)), NewUserConnection { user: UserId(Snowflake(875098534657921026)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1786476549 })) }) }; event clock=EventClock(1 => 875098531277312002) my clock=EventClock(1 => 875098531277312002)
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208246Z#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
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208540Z#x1B[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(875098534662115331)), timestamp: 1786476549, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098534657921026)), 1) }), users_to_notify: [] })
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208621Z#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(875098534662115331)), timestamp: 1786476549, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098534657921026)), 1) }), users_to_notify: [] }
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208700Z#x1B[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(875098534662115331)), timestamp: 1786476549, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098534657921026)), 2), connection: UserConnectionId(Snowflake(875098534657921027)) }), users_to_notify: [] })
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208739Z#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(875098534662115331)), timestamp: 1786476549, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098534657921026)), 2), connection: UserConnectionId(Snowflake(875098534657921027)) }), users_to_notify: [] }
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208803Z#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
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208845Z#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
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208889Z#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:29:09.208872526 UTC
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208933Z#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
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.208982Z#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
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.209029Z#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
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.209063Z#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 +
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.209111Z#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.
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.209175Z#x1B[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(875098534662115331)), timestamp: 1786476549, change: EventComplete(EventComplete), users_to_notify: [] })
1786476549.209 sable_ircd     #x1B[2m2026-08-11T19:29:09.209208Z#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(875098534662115331)), timestamp: 1786476549, change: EventComplete(EventComplete), users_to_notify: [] }
1786476549.210 S -> 2: :My.Little.Server 001 bar :Welcome to the test Internet Relay Chat network, bar
1786476549.210 S -> 2: :My.Little.Server 002 bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476549.210 S -> 2: :My.Little.Server 003 bar :This server was created 2026-08-11 19:29:09.208872526 UTC
1786476549.210 2 -> S: PING foo
1786476549.210 sable_ircd     #x1B[2m2026-08-11T19:29:09.209881Z#x1B[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
1786476549.210 sable_ircd     #x1B[2m2026-08-11T19:29:09.209920Z#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"
1786476549.210 sable_ircd     #x1B[2m2026-08-11T19:29:09.209991Z#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
1786476549.510 2 -> S: PING synchronize326.570563382
1786476549.510 S -> 2: :My.Little.Server 004 bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476549.510 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
1786476549.510 S -> 2: :My.Little.Server 422 bar :MOTD File is missing
1786476549.510 S -> 2: :bar!username@localhost MODE bar +
1786476549.510 S -> 2: :My.Little.Server NOTICE bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476549.510 S -> 2: :My.Little.Server PONG My.Little.Server :foo
1786476549.511 sable_ircd     #x1B[2m2026-08-11T19:29:09.510786Z#x1B[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
1786476549.511 sable_ircd     #x1B[2m2026-08-11T19:29:09.510856Z#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 synchronize326.570563382"
1786476549.511 sable_ircd     #x1B[2m2026-08-11T19:29:09.511003Z#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 :synchronize326.570563382
1786476549.511 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize326.570563382
1786476549.536 sable_history  #x1B[2m2027-08-11T20:21:28.354943Z#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(1007383272138940476)), timestamp: 1818015688, clock: EventClock(1 => 1007369670753259542, 50 => 1007383020484894779, 99 => 1007369673970692100), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015688 }) }; event clock=EventClock(1 => 1007369670753259542, 50 => 1007383020484894779, 99 => 1007369673970692100) my clock=EventClock(1 => 1007369670753259542, 50 => 1007383020484894779, 99 => 1007369673970692100)
1786476549.536 sable_history  #x1B[2m2027-08-11T20:21:28.356546Z#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
1786476549.549 sable_history  #x1B[2m2027-08-11T20:13:04.566512Z#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(1007381159094722610)), timestamp: 1818015184, clock: EventClock(1 => 1007369318356226049, 50 => 1007380907436482609), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015184 }) }; event clock=EventClock(1 => 1007369318356226049, 50 => 1007380907436482609) my clock=EventClock(1 => 1007369318356226049, 50 => 1007380907436482609)
1786476549.550 sable_history  #x1B[2m2027-08-11T20:13:04.568336Z#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
1786476550.059 sable_history  #x1B[2m2027-08-11T20:13:05.940606Z#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(1007381164857696307)), timestamp: 1818015185, clock: EventClock(1 => 1007369320184942593, 50 => 1007380913199456306, 99 => 1007369323750502402), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015185 }) }; event clock=EventClock(1 => 1007369320184942593, 50 => 1007380913199456306, 99 => 1007369323750502402) my clock=EventClock(1 => 1007369320184942593, 50 => 1007380913199456306, 99 => 1007369323750502402)
1786476550.059 sable_history  #x1B[2m2027-08-11T20:13:05.942801Z#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
1786476550.112 1 -> S: PING synchronize327.172764604
1786476550.113 sable_ircd     #x1B[2m2026-08-11T19:29:10.112747Z#x1B[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
1786476550.113 sable_ircd     #x1B[2m2026-08-11T19:29:10.112799Z#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 synchronize327.172764604"
1786476550.113 sable_ircd     #x1B[2m2026-08-11T19:29:10.112897Z#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 :synchronize327.172764604
1786476550.113 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize327.172764604
1786476550.213 2 -> S: PING synchronize327.273875218
1786476550.214 sable_ircd     #x1B[2m2026-08-11T19:29:10.214077Z#x1B[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
1786476550.214 sable_ircd     #x1B[2m2026-08-11T19:29:10.214160Z#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 synchronize327.273875218"
1786476550.214 sable_ircd     #x1B[2m2026-08-11T19:29:10.214304Z#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 :synchronize327.273875218
1786476550.215 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize327.273875218
1786476550.215 1 -> S: JOIN #chan
1786476550.215 sable_ircd     #x1B[2m2026-08-11T19:29:10.215013Z#x1B[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
1786476550.215 sable_ircd     #x1B[2m2026-08-11T19:29:10.215054Z#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"
1786476550.215 sable_ircd     #x1B[2m2026-08-11T19:29:10.215281Z#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(875098538885779460)), timestamp: 1786476550, clock: EventClock(1 => 875098534662115331), target: Channel(ChannelId(Snowflake(875098538885779460))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 875098534662115331) my clock=EventClock(1 => 875098534662115331)
1786476550.215 sable_ircd     #x1B[2m2026-08-11T19:29:10.215431Z#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
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.215533Z#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(875098538885779461)), timestamp: 1786476550, clock: EventClock(1 => 875098538885779460), target: Membership(MembershipId(UserId(Snowflake(875098531277312000)), ChannelId(Snowflake(875098538885779460)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(875098538885779460)), user: UserId(Snowflake(875098531277312000)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 875098538885779460) my clock=EventClock(1 => 875098538885779460)
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.215658Z#x1B[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
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.215752Z#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
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216019Z#x1B[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(875098538885779460)), timestamp: 1786476550, change: EventComplete(EventComplete), users_to_notify: [] })
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216050Z#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(875098538885779460)), timestamp: 1786476550, change: EventComplete(EventComplete), users_to_notify: [] }
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216088Z#x1B[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(875098538885779461)), timestamp: 1786476550, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(875098531277312000)), ChannelId(Snowflake(875098538885779460))), user: HistoricUserId(UserId(Snowflake(875098531277312000)), 2) }), users_to_notify: [UserId(Snowflake(875098531277312000))] })
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216114Z#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(875098538885779461)), timestamp: 1786476550, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(875098531277312000)), ChannelId(Snowflake(875098538885779460))), user: HistoricUserId(UserId(Snowflake(875098531277312000)), 2) }), users_to_notify: [UserId(Snowflake(875098531277312000))] }
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216171Z#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
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216208Z#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
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216249Z#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
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216270Z#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
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216304Z#x1B[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(875098538885779461)), timestamp: 1786476550, change: EventComplete(EventComplete), users_to_notify: [] })
1786476550.216 sable_ircd     #x1B[2m2026-08-11T19:29:10.216324Z#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(875098538885779461)), timestamp: 1786476550, change: EventComplete(EventComplete), users_to_notify: [] }
1786476550.315 1 -> S: PING synchronize327.375335368
1786476550.315 S -> 1: :foo!username@localhost JOIN #chan
1786476550.315 S -> 1: :foo!username@localhost MODE #chan +o foo
1786476550.315 S -> 1: :My.Little.Server 353 foo = #chan :@foo
1786476550.315 S -> 1: :My.Little.Server 366 foo #chan :End of names list
1786476550.316 sable_ircd     #x1B[2m2026-08-11T19:29:10.315554Z#x1B[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
1786476550.316 sable_ircd     #x1B[2m2026-08-11T19:29:10.315628Z#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 synchronize327.375335368"
1786476550.436 sable_history  #x1B[2m2027-08-11T20:24:25.927957Z#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(1007384016934084671)), timestamp: 1818015865, clock: EventClock(1 => 1007369621558267926, 50 => 1007383765275844670, 99 => 1007369624859586564), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015865 }) }; event clock=EventClock(1 => 1007369621558267926, 50 => 1007383765275844670, 99 => 1007369624859586564) my clock=EventClock(1 => 1007369621558267926, 50 => 1007383765275844670, 99 => 1007369624859586564)
1786476550.436 sable_history  #x1B[2m2027-08-11T20:24:25.929614Z#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
1786476550.479 sable_history  #x1B[2m2027-08-11T20:13:05.418523Z#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(1007381162672463923)), timestamp: 1818015185, clock: EventClock(1 => 1007369401122426895, 50 => 1007380911010029618, 99 => 1007369391161356292), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015185 }) }; event clock=EventClock(1 => 1007369401122426895, 50 => 1007380911010029618, 99 => 1007369391161356292) my clock=EventClock(1 => 1007369401122426895, 50 => 1007380911010029618, 99 => 1007369391161356292)
1786476550.479 sable_history  #x1B[2m2027-08-11T20:13:05.419984Z#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
1786476551.070 sable_ircd     #x1B[2m2026-08-11T19:29:11.069571Z#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 :synchronize327.375335368
1786476551.070 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize327.375335368
1786476551.070 1 -> S: MODE #chan +i
1786476551.070 sable_ircd     #x1B[2m2026-08-11T19:29:11.070406Z#x1B[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
1786476551.071 sable_ircd     #x1B[2m2026-08-11T19:29:11.070466Z#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"
1786476551.170 1 -> S: PING synchronize328.230729866
1786476551.171 sable_ircd     #x1B[2m2026-08-11T19:29:11.170722Z#x1B[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
1786476551.171 sable_ircd     #x1B[2m2026-08-11T19:29:11.170794Z#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 synchronize328.230729866"
1786476551.864 sable_history  #x1B[2m2027-08-11T20:16:51.133544Z#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(1007382109385596983)), timestamp: 1818015411, clock: EventClock(1 => 1007370015864786977, 50 => 1007381857723162678, 99 => 1007370023867920389), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015411 }) }; event clock=EventClock(1 => 1007370015864786977, 50 => 1007381857723162678, 99 => 1007370023867920389) my clock=EventClock(1 => 1007370015864786977, 50 => 1007381857723162678, 99 => 1007370023867920389)
1786476551.865 sable_history  #x1B[2m2027-08-11T20:16:51.135484Z#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
1786476552.060 sable_history  #x1B[2m2027-08-11T20:14:02.835619Z#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(1007381403492622387)), timestamp: 1818015242, clock: EventClock(1 => 1007369312341594113, 50 => 1007381151834382386), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015242 }) }; event clock=EventClock(1 => 1007369312341594113, 50 => 1007381151834382386) my clock=EventClock(1 => 1007369312341594113, 50 => 1007381151834382386)
1786476552.060 sable_history  #x1B[2m2027-08-11T20:14:02.837308Z#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
1786476552.171 1: waiting…
1786476552.177 sable_ircd     #x1B[2m2026-08-11T19:29:12.176467Z#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(875098547110809606)), timestamp: 1786476552, clock: EventClock(1 => 875098538885779461), target: Channel(ChannelId(Snowflake(875098538885779460))), details: ChannelModeChange(ChannelModeChange { changed_by: User(UserId(Snowflake(875098531277312000))), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange }) }; event clock=EventClock(1 => 875098538885779461) my clock=EventClock(1 => 875098538885779461)
1786476552.177 sable_ircd     #x1B[2m2026-08-11T19:29:12.176717Z#x1B[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
1786476552.177 sable_ircd     #x1B[2m2026-08-11T19:29:12.176733Z#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
1786476552.177 sable_ircd     #x1B[2m2026-08-11T19:29:12.177002Z#x1B[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(875098547110809606)), timestamp: 1786476552, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(875098538885779460)), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(875098531277312000)), 2)) }), users_to_notify: [UserId(Snowflake(875098531277312000))] })
1786476552.177 sable_ircd     #x1B[2m2026-08-11T19:29:12.177038Z#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(875098547110809606)), timestamp: 1786476552, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(875098538885779460)), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(875098531277312000)), 2)) }), users_to_notify: [UserId(Snowflake(875098531277312000))] }
1786476552.177 sable_ircd     #x1B[2m2026-08-11T19:29:12.177122Z#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
1786476552.177 sable_ircd     #x1B[2m2026-08-11T19:29:12.177221Z#x1B[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(875098547110809606)), timestamp: 1786476552, change: EventComplete(EventComplete), users_to_notify: [] })
1786476552.177 sable_ircd     #x1B[2m2026-08-11T19:29:12.177259Z#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(875098547110809606)), timestamp: 1786476552, change: EventComplete(EventComplete), users_to_notify: [] }
1786476552.178 S -> 1: :foo!username@localhost MODE #chan +i
1786476552.560 sable_history  #x1B[2m2027-08-11T20:14:03.442628Z#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(1007381406038564915)), timestamp: 1818015243, clock: EventClock(1 => 1007369314333888513, 50 => 1007381154380324914), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015243 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007381154380324914) my clock=EventClock(1 => 1007369314333888513, 50 => 1007381154380324914)
1786476552.560 sable_history  #x1B[2m2027-08-11T20:14:03.444846Z#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
1786476552.876 sable_history  #x1B[2m2027-08-11T20:19:39.717233Z#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(1007382816478142522)), timestamp: 1818015579, clock: EventClock(1 => 1007369718299889686, 50 => 1007382564824096825, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015579 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007382564824096825, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007382564824096825, 99 => 1007369721508933636)
1786476552.876 sable_history  #x1B[2m2027-08-11T20:19:39.719160Z#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
1786476553.041 sable_history  #x1B[2m2027-08-11T20:14:03.810704Z#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(1007381407586263091)), timestamp: 1818015243, clock: EventClock(1 => 1007369316242296833, 50 => 1007381155928023090), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015243 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007381155928023090) my clock=EventClock(1 => 1007369316242296833, 50 => 1007381155928023090)
1786476553.041 sable_history  #x1B[2m2027-08-11T20:14:03.812328Z#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
1786476553.179 1: waiting…
1786476553.182 sable_ircd     #x1B[2m2026-08-11T19:29:13.181702Z#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 :synchronize328.230729866
1786476553.182 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize328.230729866
1786476553.182 1 -> S: MODE #chan -o foo
1786476553.182 sable_ircd     #x1B[2m2026-08-11T19:29:13.182417Z#x1B[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
1786476553.183 sable_ircd     #x1B[2m2026-08-11T19:29:13.182473Z#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 -o foo"
1786476553.282 1 -> S: PING synchronize330.342794672
1786476553.283 sable_ircd     #x1B[2m2026-08-11T19:29:13.282776Z#x1B[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
1786476553.283 sable_ircd     #x1B[2m2026-08-11T19:29:13.282852Z#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 synchronize330.342794672"
1786476553.536 sable_history  #x1B[2m2027-08-11T20:22:28.355576Z#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(1007383523797180477)), timestamp: 1818015748, clock: EventClock(1 => 1007369670753259542, 50 => 1007383272138940476, 99 => 1007369673970692100), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015748 }) }; event clock=EventClock(1 => 1007369670753259542, 50 => 1007383272138940476, 99 => 1007369673970692100) my clock=EventClock(1 => 1007369670753259542, 50 => 1007383272138940476, 99 => 1007369673970692100)
1786476553.536 sable_history  #x1B[2m2027-08-11T20:22:28.357097Z#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
1786476553.550 sable_history  #x1B[2m2027-08-11T20:14:04.567331Z#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(1007381410757156915)), timestamp: 1818015244, clock: EventClock(1 => 1007369318356226049, 50 => 1007381159094722610), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015244 }) }; event clock=EventClock(1 => 1007369318356226049, 50 => 1007381159094722610) my clock=EventClock(1 => 1007369318356226049, 50 => 1007381159094722610)
1786476553.550 sable_history  #x1B[2m2027-08-11T20:14:04.569508Z#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
1786476554.038 sable_ircd     #x1B[2m2026-08-11T19:29:14.037969Z#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(875098554916409351)), timestamp: 1786476554, clock: EventClock(1 => 875098547110809606), target: Membership(MembershipId(UserId(Snowflake(875098531277312000)), ChannelId(Snowflake(875098538885779460)))), details: MembershipFlagChange(MembershipFlagChange { changed_by: User(UserId(Snowflake(875098531277312000))), added: MembershipFlagSet(0), removed: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 875098547110809606) my clock=EventClock(1 => 875098547110809606)
1786476554.038 sable_ircd     #x1B[2m2026-08-11T19:29:14.038189Z#x1B[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
1786476554.038 sable_ircd     #x1B[2m2026-08-11T19:29:14.038210Z#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
1786476554.039 sable_ircd     #x1B[2m2026-08-11T19:29:14.038484Z#x1B[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(875098554916409351)), timestamp: 1786476554, change: MembershipFlagChange(MembershipFlagChange { membership: MembershipId(UserId(Snowflake(875098531277312000)), ChannelId(Snowflake(875098538885779460))), user: HistoricUserId(UserId(Snowflake(875098531277312000)), 2), added: MembershipFlagSet(0), removed: MembershipFlagSet(1), changed_by: User(HistoricUserId(UserId(Snowflake(875098531277312000)), 2)) }), users_to_notify: [UserId(Snowflake(875098531277312000))] })
1786476554.039 sable_ircd     #x1B[2m2026-08-11T19:29:14.038577Z#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(875098554916409351)), timestamp: 1786476554, change: MembershipFlagChange(MembershipFlagChange { membership: MembershipId(UserId(Snowflake(875098531277312000)), ChannelId(Snowflake(875098538885779460))), user: HistoricUserId(UserId(Snowflake(875098531277312000)), 2), added: MembershipFlagSet(0), removed: MembershipFlagSet(1), changed_by: User(HistoricUserId(UserId(Snowflake(875098531277312000)), 2)) }), users_to_notify: [UserId(Snowflake(875098531277312000))] }
1786476554.039 sable_ircd     #x1B[2m2026-08-11T19:29:14.038658Z#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
1786476554.039 sable_ircd     #x1B[2m2026-08-11T19:29:14.038744Z#x1B[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(875098554916409351)), timestamp: 1786476554, change: EventComplete(EventComplete), users_to_notify: [] })
1786476554.039 sable_ircd     #x1B[2m2026-08-11T19:29:14.038772Z#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(875098554916409351)), timestamp: 1786476554, change: EventComplete(EventComplete), users_to_notify: [] }
1786476554.039 S -> 1: :foo!username@localhost MODE #chan -o foo
1786476554.059 sable_history  #x1B[2m2027-08-11T20:14:05.941020Z#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(1007381416515936308)), timestamp: 1818015245, clock: EventClock(1 => 1007369320184942593, 50 => 1007381164857696307, 99 => 1007369323750502402), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015245 }) }; event clock=EventClock(1 => 1007369320184942593, 50 => 1007381164857696307, 99 => 1007369323750502402) my clock=EventClock(1 => 1007369320184942593, 50 => 1007381164857696307, 99 => 1007369323750502402)
1786476554.059 sable_history  #x1B[2m2027-08-11T20:14:05.943206Z#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
1786476554.436 sable_history  #x1B[2m2027-08-11T20:25:25.927924Z#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(1007384268592324672)), timestamp: 1818015925, clock: EventClock(1 => 1007369621558267926, 50 => 1007384016934084671, 99 => 1007369624859586564), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015925 }) }; event clock=EventClock(1 => 1007369621558267926, 50 => 1007384016934084671, 99 => 1007369624859586564) my clock=EventClock(1 => 1007369621558267926, 50 => 1007384016934084671, 99 => 1007369624859586564)
1786476554.436 sable_history  #x1B[2m2027-08-11T20:25:25.929595Z#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
1786476554.479 sable_history  #x1B[2m2027-08-11T20:14:05.419074Z#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(1007381414330703924)), timestamp: 1818015245, clock: EventClock(1 => 1007369401122426895, 50 => 1007381162672463923, 99 => 1007369391161356292), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015245 }) }; event clock=EventClock(1 => 1007369401122426895, 50 => 1007381162672463923, 99 => 1007369391161356292) my clock=EventClock(1 => 1007369401122426895, 50 => 1007381162672463923, 99 => 1007369391161356292)
1786476554.479 sable_history  #x1B[2m2027-08-11T20:14:05.420464Z#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
1786476555.040 1: waiting…
1786476555.045 sable_ircd     #x1B[2m2026-08-11T19:29:15.044415Z#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 :synchronize330.342794672
1786476555.045 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize330.342794672
1786476555.045 1 -> S: INVITE bar #chan
1786476555.045 sable_ircd     #x1B[2m2026-08-11T19:29:15.045392Z#x1B[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
1786476555.046 sable_ircd     #x1B[2m2026-08-11T19:29:15.045461Z#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"
1786476555.145 1 -> S: PING synchronize332.205616224
1786476555.146 sable_ircd     #x1B[2m2026-08-11T19:29:15.145566Z#x1B[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
1786476555.146 sable_ircd     #x1B[2m2026-08-11T19:29:15.145629Z#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 synchronize332.205616224"
1786476555.864 sable_history  #x1B[2m2027-08-11T20:17:51.132340Z#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(1007382361039642680)), timestamp: 1818015471, clock: EventClock(1 => 1007370015864786977, 50 => 1007382109385596983, 99 => 1007370023867920389), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015471 }) }; event clock=EventClock(1 => 1007370015864786977, 50 => 1007382109385596983, 99 => 1007370023867920389) my clock=EventClock(1 => 1007370015864786977, 50 => 1007382109385596983, 99 => 1007370023867920389)
1786476555.864 sable_history  #x1B[2m2027-08-11T20:17:51.133962Z#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
1786476556.060 sable_history  #x1B[2m2027-08-11T20:15:02.835241Z#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(1007381655150862388)), timestamp: 1818015302, clock: EventClock(1 => 1007369312341594113, 50 => 1007381403492622387), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015302 }) }; event clock=EventClock(1 => 1007369312341594113, 50 => 1007381403492622387) my clock=EventClock(1 => 1007369312341594113, 50 => 1007381403492622387)
1786476556.060 sable_history  #x1B[2m2027-08-11T20:15:02.836959Z#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
1786476556.145 1: waiting…
1786476556.150 sable_ircd     #x1B[2m2026-08-11T19:29:16.149986Z#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 482 foo #chan :You're not a channel operator
1786476556.150 S -> 1: :My.Little.Server 482 foo #chan :You're not a channel operator
1786476556.560 sable_history  #x1B[2m2027-08-11T20:15:03.443248Z#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(1007381657700999220)), timestamp: 1818015303, clock: EventClock(1 => 1007369314333888513, 50 => 1007381406038564915), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015303 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007381406038564915) my clock=EventClock(1 => 1007369314333888513, 50 => 1007381406038564915)
1786476556.560 sable_history  #x1B[2m2027-08-11T20:15:03.445329Z#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
1786476556.876 sable_history  #x1B[2m2027-08-11T20:20:39.718135Z#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(1007383068140576827)), timestamp: 1818015639, clock: EventClock(1 => 1007369718299889686, 50 => 1007382816478142522, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015639 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007382816478142522, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007382816478142522, 99 => 1007369721508933636)
1786476556.876 sable_history  #x1B[2m2027-08-11T20:20:39.719887Z#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
1786476557.041 sable_history  #x1B[2m2027-08-11T20:15:03.810984Z#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(1007381659244503092)), timestamp: 1818015303, clock: EventClock(1 => 1007369316242296833, 50 => 1007381407586263091), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015303 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007381407586263091) my clock=EventClock(1 => 1007369316242296833, 50 => 1007381407586263091)
1786476557.041 sable_history  #x1B[2m2027-08-11T20:15:03.813004Z#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
1786476557.152 1: waiting…
1786476557.154 sable_ircd     #x1B[2m2026-08-11T19:29:17.153802Z#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 :synchronize332.205616224
1786476557.154 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize332.205616224
1786476557.157 1: disconnects from server.
1786476557.157 2: disconnects from server.