--------------------------------- Captured Out --------------------------------- ---- new test ---- 1782833833.202 sable_ircd uid=1001 1782833833.205 sable_ircd #x1B[2m2026-06-30T15:37:13.205302Z#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(859819876359868416)), timestamp: 1782833833, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833833, name: ServerName("My.Little.Server"), ts: 1782833833, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1782833833.205 sable_ircd #x1B[2m2026-06-30T15:37:13.205450Z#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 1782833833.206 sable_ircd #x1B[2m2026-06-30T15:37:13.205665Z#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(859819876359868416)), timestamp: 1782833833, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833833, name: ServerName("My.Little.Server"), ts: 1782833833, 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 1782833833.206 sable_ircd #x1B[2m2026-06-30T15:37:13.205853Z#x1B[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(859819876359868416)), timestamp: 1782833833, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1782833833.206 sable_ircd #x1B[2m2026-06-30T15:37:13.205894Z#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(859819876359868416)), timestamp: 1782833833, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1782833833.206 sable_ircd #x1B[2m2026-06-30T15:37:13.205930Z#x1B[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(859819876359868416)), timestamp: 1782833833, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833833.206 sable_ircd #x1B[2m2026-06-30T15:37:13.205956Z#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(859819876359868416)), timestamp: 1782833833, change: EventComplete(EventComplete), users_to_notify: [] } 1782833833.207 sable_ircd #x1B[2m2026-06-30T15:37:13.206685Z#x1B[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 1782833833.207 sable_ircd #x1B[2m2026-06-30T15:37:13.207060Z#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(859819876368257025)), timestamp: 1782833833, clock: EventClock(1 => 859819876359868416), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1782833833 }) }; event clock=EventClock(1 => 859819876359868416) my clock=EventClock(1 => 859819876359868416) 1782833833.207 sable_ircd #x1B[2m2026-06-30T15:37:13.207155Z#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 1782833833.207 sable_ircd #x1B[2m2026-06-30T15:37:13.207429Z#x1B[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(859819876368257025)), timestamp: 1782833833, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833833.208 sable_ircd #x1B[2m2026-06-30T15:37:13.207503Z#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(859819876368257025)), timestamp: 1782833833, change: EventComplete(EventComplete), users_to_notify: [] } 1782833833.296 sable_ircd #x1B[2m2026-06-30T15:37:13.295977Z#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 } 1782833833.296 sable_ircd #x1B[2m2026-06-30T15:37:13.296145Z#x1B[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 1782833833.296 sable_ircd #x1B[2m2026-06-30T15:37:13.296196Z#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 1782833833.296 sable_ircd #x1B[2m2026-06-30T15:37:13.296250Z#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 1782833833.297 sable_ircd #x1B[2m2026-06-30T15:37:13.296427Z#x1B[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 1782833833.297 sable_ircd #x1B[2m2026-06-30T15:37:13.296490Z#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" 1782833833.297 sable_ircd #x1B[2m2026-06-30T15:37:13.296592Z#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 1782833833.297 sable_ircd #x1B[2m2026-06-30T15:37:13.296692Z#x1B[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)) 1782833833.297 sable_ircd #x1B[2m2026-06-30T15:37:13.296731Z#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) 1782833833.297 sable_ircd #x1B[2m2026-06-30T15:37:13.297275Z#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 1782833833.297 sable_ircd #x1B[2m2026-06-30T15:37:13.297431Z#x1B[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 1782833833.299 sable_ircd #x1B[2m2026-06-30T15:37:13.298662Z#x1B[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 1782833833.317 baz: connects to server. 1782833833.317 baz -> S: NICK baz 1782833833.317 baz -> S: USER username * * :Realname 1782833833.317 sable_ircd #x1B[2m2026-06-30T15:37:13.317400Z#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 } 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.317524Z#x1B[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 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.317575Z#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 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.317638Z#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 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.317771Z#x1B[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 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.317820Z#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" 1782833833.318 S -> baz: :My.Little.Server NOTICE * :*** Looking up your hostname 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.318043Z#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: 617, tv_nsec: 541266590 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("baz")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.318114Z#x1B[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 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.318155Z#x1B[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 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.318186Z#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" 1782833833.318 sable_ircd #x1B[2m2026-06-30T15:37:13.318255Z#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: 617, tv_nsec: 541266590 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("baz")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1782833833.319 sable_ircd #x1B[2m2026-06-30T15:37:13.318714Z#x1B[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 1782833833.319 sable_ircd #x1B[2m2026-06-30T15:37:13.318755Z#x1B[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")) 1782833833.319 sable_ircd #x1B[2m2026-06-30T15:37:13.318787Z#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 1782833833.319 sable_ircd #x1B[2m2026-06-30T15:37:13.318809Z#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: 617, tv_nsec: 541266590 }, attach_user_id: OnceLock(), 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(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1782833833.319 sable_ircd #x1B[2m2026-06-30T15:37:13.318850Z#x1B[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)) 1782833833.319 sable_ircd #x1B[2m2026-06-30T15:37:13.319061Z#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(859819876838019074)), timestamp: 1782833833, clock: EventClock(1 => 859819876368257025), target: User(UserId(Snowflake(859819876833824768))), 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(859819876833824769)), NewUserConnection { user: UserId(Snowflake(859819876833824768)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833833 })) }) }; event clock=EventClock(1 => 859819876368257025) my clock=EventClock(1 => 859819876368257025) 1782833833.319 sable_ircd #x1B[2m2026-06-30T15:37:13.319149Z#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 1782833833.319 S -> baz: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319468Z#x1B[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(859819876838019074)), timestamp: 1782833833, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819876833824768)), 1) }), users_to_notify: [] }) 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319511Z#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(859819876838019074)), timestamp: 1782833833, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819876833824768)), 1) }), users_to_notify: [] } 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319555Z#x1B[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(859819876838019074)), timestamp: 1782833833, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819876833824768)), 2), connection: UserConnectionId(Snowflake(859819876833824769)) }), users_to_notify: [] }) 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319578Z#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(859819876838019074)), timestamp: 1782833833, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819876833824768)), 2), connection: UserConnectionId(Snowflake(859819876833824769)) }), users_to_notify: [] } 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319618Z#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 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319648Z#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 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319670Z#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:13.319663189 UTC 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319686Z#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 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319715Z#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 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319732Z#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 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319750Z#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 + 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319764Z#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. 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319807Z#x1B[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(859819876838019074)), timestamp: 1782833833, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833833.320 sable_ircd #x1B[2m2026-06-30T15:37:13.319830Z#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(859819876838019074)), timestamp: 1782833833, change: EventComplete(EventComplete), users_to_notify: [] } 1782833833.320 S -> baz: :My.Little.Server 001 baz :Welcome to the test Internet Relay Chat network, baz 1782833833.320 S -> baz: :My.Little.Server 002 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1782833833.320 S -> baz: :My.Little.Server 003 baz :This server was created 2026-06-30 15:37:13.319663189 UTC 1782833833.320 S -> baz: :My.Little.Server 004 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1782833833.320 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 1782833833.320 S -> baz: :My.Little.Server 422 baz :MOTD File is missing 1782833833.320 S -> baz: :baz!username@localhost MODE baz + 1782833833.320 S -> baz: :My.Little.Server NOTICE baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1782833833.320 baz -> S: PING foo 1782833833.321 sable_ircd #x1B[2m2026-06-30T15:37:13.320502Z#x1B[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 1782833833.321 sable_ircd #x1B[2m2026-06-30T15:37:13.320544Z#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" 1782833833.321 sable_ircd #x1B[2m2026-06-30T15:37:13.320614Z#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 1782833833.338 sable_history #x1B[2m2027-06-30T16:41:40.204275Z#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(992107666669248585)), timestamp: 1814373700, clock: EventClock(1 => 992090315928113159, 50 => 992107415011008584, 99 => 992090295988793346), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814373700 }) }; event clock=EventClock(1 => 992090315928113159, 50 => 992107415011008584, 99 => 992090295988793346) my clock=EventClock(1 => 992090315928113159, 50 => 992107415011008584, 99 => 992090295988793346) 1782833833.338 sable_history #x1B[2m2027-06-30T16:41:40.206602Z#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 1782833833.819 sable_history #x1B[2m2027-06-30T16:41:40.675297Z#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(992107668644765769)), timestamp: 1814373700, clock: EventClock(1 => 992090370923827215, 50 => 992107416990720072, 99 => 992090360975339524), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814373700 }) }; event clock=EventClock(1 => 992090370923827215, 50 => 992107416990720072, 99 => 992090360975339524) my clock=EventClock(1 => 992090370923827215, 50 => 992107416990720072, 99 => 992090360975339524) 1782833833.819 sable_history #x1B[2m2027-06-30T16:41:40.676829Z#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 1782833833.921 sable_history #x1B[2m2027-06-30T16:52:52.958355Z#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(992110488404041813)), timestamp: 1814374372, clock: EventClock(1 => 992090594522173462, 50 => 992110236749996116, 99 => 992090597802520580), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814374372 }) }; event clock=EventClock(1 => 992090594522173462, 50 => 992110236749996116, 99 => 992090597802520580) my clock=EventClock(1 => 992090594522173462, 50 => 992110236749996116, 99 => 992090597802520580) 1782833833.921 sable_history #x1B[2m2027-06-30T16:52:52.959562Z#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 1782833834.121 baz -> S: PING synchronize618.344791463 1782833834.121 S -> baz: :My.Little.Server PONG My.Little.Server :foo 1782833834.122 sable_ircd #x1B[2m2026-06-30T15:37:14.121575Z#x1B[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 1782833834.122 sable_ircd #x1B[2m2026-06-30T15:37:14.121634Z#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 synchronize618.344791463" 1782833834.122 sable_ircd #x1B[2m2026-06-30T15:37:14.121749Z#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 :synchronize618.344791463 1782833834.122 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize618.344791463 1782833834.122 baz -> S: OPER operuser nottheoperpassword 1782833834.122 sable_ircd #x1B[2m2026-06-30T15:37:14.122374Z#x1B[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 1782833834.122 sable_ircd #x1B[2m2026-06-30T15:37:14.122437Z#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 nottheoperpassword" 1782833834.222 baz -> S: PING synchronize618.445913683 1782833834.232 sable_ircd #x1B[2m2026-06-30T15:37:14.231772Z#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 491 baz :No oper configuration found 1782833834.232 sable_ircd #x1B[2m2026-06-30T15:37:14.232027Z#x1B[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 1782833834.232 S -> baz: :My.Little.Server 491 baz :No oper configuration found1782833834.232 sable_ircd #x1B[2m2026-06-30T15:37:14.232084Z#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 synchronize618.445913683" 1782833834.778 sable_history #x1B[2m2027-06-30T16:55:55.473466Z#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(992111253927436376)), timestamp: 1814374555, clock: EventClock(1 => 992090797555847191, 50 => 992111002273390679, 99 => 992090799858921477), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814374555 }) }; event clock=EventClock(1 => 992090797555847191, 50 => 992111002273390679, 99 => 992090799858921477) my clock=EventClock(1 => 992090797555847191, 50 => 992111002273390679, 99 => 992090799858921477) 1782833834.778 sable_history #x1B[2m2027-06-30T16:55:55.474964Z#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.233 baz: waiting… 1782833835.237 sable_ircd #x1B[2m2026-06-30T15:37:15.236463Z#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 :synchronize618.445913683 1782833835.237 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize618.445913683 1782833835.242 baz: disconnects from server.