--------------------------------- Captured Out ---------------------------------
---- new test ----
1782833835.252 sable_ircd     uid=1001
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.255345Z#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(859819884958191616)), timestamp: 1782833835, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833835, name: ServerName("My.Little.Server"), ts: 1782833835, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.255489Z#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
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.255692Z#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(859819884958191616)), timestamp: 1782833835, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833835, name: ServerName("My.Little.Server"), ts: 1782833835, 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
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.255889Z#x1B[0m #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(859819884958191616)), timestamp: 1782833835, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.255929Z#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(859819884958191616)), timestamp: 1782833835, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.255974Z#x1B[0m #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(859819884958191616)), timestamp: 1782833835, change: EventComplete(EventComplete), users_to_notify: [] })
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.256002Z#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(859819884958191616)), timestamp: 1782833835, change: EventComplete(EventComplete), users_to_notify: [] }
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.256124Z#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(859819884962385921)), timestamp: 1782833835, clock: EventClock(1 => 859819884958191616), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1782833835 }) }; event clock=EventClock(1 => 859819884958191616) my clock=EventClock(1 => 859819884958191616)
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.256181Z#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
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.256427Z#x1B[0m #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(859819884962385921)), timestamp: 1782833835, change: EventComplete(EventComplete), users_to_notify: [] })
1782833835.257 sable_ircd     #x1B[2m2026-06-30T15:37:15.256462Z#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(859819884962385921)), timestamp: 1782833835, change: EventComplete(EventComplete), users_to_notify: [] }
1782833835.258 sable_ircd     #x1B[2m2026-06-30T15:37:15.257394Z#x1B[0m #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
1782833835.327 sable_history  #x1B[2m2027-06-30T16:45:26.204040Z#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(992108614581952589)), timestamp: 1814373926, clock: EventClock(1 => 992090986400190497, 50 => 992108362923712588, 99 => 992090992696242181), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814373926 }) }; event clock=EventClock(1 => 992090986400190497, 50 => 992108362923712588, 99 => 992090992696242181) my clock=EventClock(1 => 992090986400190497, 50 => 992108362923712588, 99 => 992090992696242181)
1782833835.327 sable_history  #x1B[2m2027-06-30T16:45:26.205529Z#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
1782833835.348 sable_ircd     #x1B[2m2026-06-30T15:37:15.348140Z#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 }
1782833835.348 sable_ircd     #x1B[2m2026-06-30T15:37:15.348291Z#x1B[0m #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
1782833835.348 sable_ircd     #x1B[2m2026-06-30T15:37:15.348349Z#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
1782833835.349 sable_ircd     #x1B[2m2026-06-30T15:37:15.348455Z#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
1782833835.349 sable_ircd     #x1B[2m2026-06-30T15:37:15.348615Z#x1B[0m #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
1782833835.349 sable_ircd     #x1B[2m2026-06-30T15:37:15.348669Z#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"
1782833835.349 sable_ircd     #x1B[2m2026-06-30T15:37:15.348859Z#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
1782833835.349 sable_ircd     #x1B[2m2026-06-30T15:37:15.348981Z#x1B[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))
1782833835.349 sable_ircd     #x1B[2m2026-06-30T15:37:15.349026Z#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)
1782833835.350 sable_ircd     #x1B[2m2026-06-30T15:37:15.349545Z#x1B[0m #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
1782833835.350 sable_ircd     #x1B[2m2026-06-30T15:37:15.349679Z#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
1782833835.350 sable_ircd     #x1B[2m2026-06-30T15:37:15.349739Z#x1B[0m #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
1782833835.369 baz: connects to server.
1782833835.369 baz -> S: NICK baz
1782833835.369 baz -> S: USER username * * :Realname
1782833835.369 sable_ircd     #x1B[2m2026-06-30T15:37:15.369398Z#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 }
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.369498Z#x1B[0m #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
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.369532Z#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
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.369571Z#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
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.369708Z#x1B[0m #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
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.369766Z#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 baz"
1782833835.370 S -> baz: :My.Little.Server NOTICE * :*** Looking up your hostname
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.369893Z#x1B[0m #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
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.369951Z#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"
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.370043Z#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: 619, tv_nsec: 593210712 }, 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
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.370137Z#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: 619, tv_nsec: 593210712 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("baz")), 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
1782833835.370 sable_ircd     #x1B[2m2026-06-30T15:37:15.370197Z#x1B[0m #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
1782833835.371 sable_ircd     #x1B[2m2026-06-30T15:37:15.370618Z#x1B[0m #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
1782833835.371 sable_ircd     #x1B[2m2026-06-30T15:37:15.370658Z#x1B[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"))
1782833835.371 sable_ircd     #x1B[2m2026-06-30T15:37:15.370687Z#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
1782833835.371 sable_ircd     #x1B[2m2026-06-30T15:37:15.370709Z#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: 619, tv_nsec: 593210712 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("baz")), 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
1782833835.371 sable_ircd     #x1B[2m2026-06-30T15:37:15.370749Z#x1B[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))
1782833835.371 sable_ircd     #x1B[2m2026-06-30T15:37:15.370991Z#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(859819885440536578)), timestamp: 1782833835, clock: EventClock(1 => 859819884962385921), target: User(UserId(Snowflake(859819885440536576))), details: NewUser(NewUser { nickname: Nickname("baz"), 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(859819885440536577)), NewUserConnection { user: UserId(Snowflake(859819885440536576)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833835 })) }) }; event clock=EventClock(1 => 859819884962385921) my clock=EventClock(1 => 859819884962385921)
1782833835.371 S -> baz: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1782833835.371 sable_ircd     #x1B[2m2026-06-30T15:37:15.371101Z#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
1782833835.371 sable_ircd     #x1B[2m2026-06-30T15:37:15.371389Z#x1B[0m #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(859819885440536578)), timestamp: 1782833835, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819885440536576)), 1) }), users_to_notify: [] })
1782833835.371 sable_ircd     #x1B[2m2026-06-30T15:37:15.371432Z#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(859819885440536578)), timestamp: 1782833835, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819885440536576)), 1) }), users_to_notify: [] }
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371476Z#x1B[0m #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(859819885440536578)), timestamp: 1782833835, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819885440536576)), 2), connection: UserConnectionId(Snowflake(859819885440536577)) }), users_to_notify: [] })
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371499Z#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(859819885440536578)), timestamp: 1782833835, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819885440536576)), 2), connection: UserConnectionId(Snowflake(859819885440536577)) }), users_to_notify: [] }
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371546Z#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 baz :Welcome to the test Internet Relay Chat network, baz
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371573Z#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 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371596Z#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 baz :This server was created 2026-06-30 15:37:15.371587264 UTC
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371613Z#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 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371644Z#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 baz 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
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371663Z#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 baz :MOTD File is missing
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371686Z#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): :baz!username@localhost MODE baz +
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371702Z#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 baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371740Z#x1B[0m #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(859819885440536578)), timestamp: 1782833835, change: EventComplete(EventComplete), users_to_notify: [] })
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.371761Z#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(859819885440536578)), timestamp: 1782833835, change: EventComplete(EventComplete), users_to_notify: [] }
1782833835.372 S -> baz: :My.Little.Server 001 baz :Welcome to the test Internet Relay Chat network, baz
1782833835.372 baz -> S: PING foo
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.372257Z#x1B[0m #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
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.372308Z#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"
1782833835.372 sable_ircd     #x1B[2m2026-06-30T15:37:15.372429Z#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
1782833835.472 baz -> S: PING synchronize619.695810505
1782833835.472 S -> baz: :My.Little.Server 002 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1782833835.472 S -> baz: :My.Little.Server 003 baz :This server was created 2026-06-30 15:37:15.371587264 UTC
1782833835.472 S -> baz: :My.Little.Server 004 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1782833835.472 S -> baz: :My.Little.Server 005 baz 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
1782833835.472 S -> baz: :My.Little.Server 422 baz :MOTD File is missing
1782833835.472 S -> baz: :baz!username@localhost MODE baz +
1782833835.472 S -> baz: :My.Little.Server NOTICE baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1782833835.472 S -> baz: :My.Little.Server PONG My.Little.Server :foo
1782833835.473 sable_ircd     #x1B[2m2026-06-30T15:37:15.472573Z#x1B[0m #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
1782833835.473 sable_ircd     #x1B[2m2026-06-30T15:37:15.472634Z#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 synchronize619.695810505"
1782833835.473 sable_ircd     #x1B[2m2026-06-30T15:37:15.472750Z#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 :synchronize619.695810505
1782833835.473 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize619.695810505
1782833835.553 sable_history  #x1B[2m2027-06-30T16:42:38.916601Z#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(992107912925225033)), timestamp: 1814373758, clock: EventClock(1 => 992090282621145089, 50 => 992107661271179336), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814373758 }) }; event clock=EventClock(1 => 992090282621145089, 50 => 992107661271179336) my clock=EventClock(1 => 992090282621145089, 50 => 992107661271179336)
1782833835.553 sable_history  #x1B[2m2027-06-30T16:42:38.918137Z#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
1782833836.001 sable_history  #x1B[2m2027-06-30T16:42:38.827073Z#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(992107912551931977)), timestamp: 1814373758, clock: EventClock(1 => 992090284479221761, 50 => 992107660893691976), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814373758 }) }; event clock=EventClock(1 => 992090284479221761, 50 => 992107660893691976) my clock=EventClock(1 => 992090284479221761, 50 => 992107660893691976)
1782833836.001 sable_history  #x1B[2m2027-06-30T16:42:38.828687Z#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
1782833836.174 baz -> S: OPER operuser
1782833836.175 sable_ircd     #x1B[2m2026-06-30T15:37:16.174509Z#x1B[0m #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
1782833836.175 sable_ircd     #x1B[2m2026-06-30T15:37:16.174584Z#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"OPER operuser"
1782833836.175 sable_ircd     #x1B[2m2026-06-30T15:37:16.174731Z#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 461 baz OPER :Not enough parameters
1782833836.274 baz -> S: PING synchronize620.497832365
1782833836.274 S -> baz: :My.Little.Server 461 baz OPER :Not enough parameters
1782833836.275 sable_ircd     #x1B[2m2026-06-30T15:37:16.274632Z#x1B[0m #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
1782833836.275 sable_ircd     #x1B[2m2026-06-30T15:37:16.274705Z#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 synchronize620.497832365"
1782833836.395 sable_history  #x1B[2m2027-06-30T16:48:15.218349Z#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(992109323478048848)), timestamp: 1814374095, clock: EventClock(1 => 992090688797544470, 50 => 992109071815614543, 99 => 992090692702842884), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814374095 }) }; event clock=EventClock(1 => 992090688797544470, 50 => 992109071815614543, 99 => 992090692702842884) my clock=EventClock(1 => 992090688797544470, 50 => 992109071815614543, 99 => 992090692702842884)
1782833836.395 sable_history  #x1B[2m2027-06-30T16:48:15.220179Z#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
1782833836.447 sable_history  #x1B[2m2027-06-30T16:42:39.243862Z#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(992107914300956745)), timestamp: 1814373759, clock: EventClock(1 => 992090293064962051, 50 => 992107662638522440), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814373759 }) }; event clock=EventClock(1 => 992090293064962051, 50 => 992107662638522440) my clock=EventClock(1 => 992090293064962051, 50 => 992107662638522440)
1782833836.447 sable_history  #x1B[2m2027-06-30T16:42:39.245712Z#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
1782833836.901 sable_history  #x1B[2m2027-06-30T16:42:39.931884Z#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(992107917186637897)), timestamp: 1814373759, clock: EventClock(1 => 992090288103100417, 50 => 992107665520009288), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814373759 }) }; event clock=EventClock(1 => 992090288103100417, 50 => 992107665520009288) my clock=EventClock(1 => 992090288103100417, 50 => 992107665520009288)
1782833836.901 sable_history  #x1B[2m2027-06-30T16:42:39.933965Z#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
1782833837.014 sable_history  #x1B[2m2027-06-30T16:51:03.931407Z#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(992110031111659603)), timestamp: 1814374263, clock: EventClock(1 => 992090641066364950, 50 => 992109779457613906, 99 => 992090644996829188), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814374263 }) }; event clock=EventClock(1 => 992090641066364950, 50 => 992109779457613906, 99 => 992090644996829188) my clock=EventClock(1 => 992090641066364950, 50 => 992109779457613906, 99 => 992090644996829188)
1782833837.014 sable_history  #x1B[2m2027-06-30T16:51:03.932761Z#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
1782833837.030 sable_ircd     #x1B[2m2026-06-30T15:37:17.029583Z#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 :synchronize620.497832365
1782833837.030 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize620.497832365
1782833837.035 baz: disconnects from server.