--------------------------------- Captured Out --------------------------------- ---- new test ---- 1782833837.045 sable_ircd uid=1001 1782833837.048 sable_ircd #x1B[2m2026-06-30T15:37:17.048306Z#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(859819892478578688)), timestamp: 1782833837, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833837, name: ServerName("My.Little.Server"), ts: 1782833837, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1782833837.048 sable_ircd #x1B[2m2026-06-30T15:37:17.048449Z#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.049 sable_ircd #x1B[2m2026-06-30T15:37:17.048689Z#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(859819892478578688)), timestamp: 1782833837, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833837, name: ServerName("My.Little.Server"), ts: 1782833837, 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 1782833837.049 sable_ircd #x1B[2m2026-06-30T15:37:17.048791Z#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 1782833837.049 sable_ircd #x1B[2m2026-06-30T15:37:17.048862Z#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(859819892478578688)), timestamp: 1782833837, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1782833837.049 sable_ircd #x1B[2m2026-06-30T15:37:17.048852Z#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(859819892478578689)), timestamp: 1782833837, clock: EventClock(1 => 859819892478578688), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1782833837 }) }; event clock=EventClock(1 => 859819892478578688) my clock=EventClock(1 => 859819892478578688) 1782833837.049 sable_ircd #x1B[2m2026-06-30T15:37:17.048904Z#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(859819892478578688)), timestamp: 1782833837, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1782833837.049 sable_ircd #x1B[2m2026-06-30T15:37:17.048923Z#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.049 sable_ircd #x1B[2m2026-06-30T15:37:17.048986Z#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(859819892478578688)), timestamp: 1782833837, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833837.049 sable_ircd #x1B[2m2026-06-30T15:37:17.049021Z#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(859819892478578688)), timestamp: 1782833837, change: EventComplete(EventComplete), users_to_notify: [] } 1782833837.049 sable_ircd #x1B[2m2026-06-30T15:37:17.049092Z#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(859819892478578689)), timestamp: 1782833837, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833837.049 sable_ircd #x1B[2m2026-06-30T15:37:17.049126Z#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(859819892478578689)), timestamp: 1782833837, change: EventComplete(EventComplete), users_to_notify: [] } 1782833837.141 sable_ircd #x1B[2m2026-06-30T15:37:17.140876Z#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 } 1782833837.141 sable_ircd #x1B[2m2026-06-30T15:37:17.141043Z#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 1782833837.141 sable_ircd #x1B[2m2026-06-30T15:37:17.141119Z#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 1782833837.141 sable_ircd #x1B[2m2026-06-30T15:37:17.141181Z#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 1782833837.141 sable_ircd #x1B[2m2026-06-30T15:37:17.141337Z#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 1782833837.142 sable_ircd #x1B[2m2026-06-30T15:37:17.141451Z#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" 1782833837.142 sable_ircd #x1B[2m2026-06-30T15:37:17.141574Z#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 1782833837.142 sable_ircd #x1B[2m2026-06-30T15:37:17.141679Z#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)) 1782833837.142 sable_ircd #x1B[2m2026-06-30T15:37:17.141722Z#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) 1782833837.142 sable_ircd #x1B[2m2026-06-30T15:37:17.142206Z#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 1782833837.142 sable_ircd #x1B[2m2026-06-30T15:37:17.142326Z#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 1782833837.142 sable_ircd #x1B[2m2026-06-30T15:37:17.142419Z#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 1782833837.162 baz: connects to server. 1782833837.162 baz -> S: NICK baz 1782833837.162 baz -> S: USER username * * :Realname 1782833837.162 sable_ircd #x1B[2m2026-06-30T15:37:17.162145Z#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 } 1782833837.162 sable_ircd #x1B[2m2026-06-30T15:37:17.162278Z#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 1782833837.162 sable_ircd #x1B[2m2026-06-30T15:37:17.162340Z#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 1782833837.163 sable_ircd #x1B[2m2026-06-30T15:37:17.162439Z#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 1782833837.163 sable_ircd #x1B[2m2026-06-30T15:37:17.162630Z#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 1782833837.163 sable_ircd #x1B[2m2026-06-30T15:37:17.162694Z#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" 1782833837.163 S -> baz: :My.Little.Server NOTICE * :*** Looking up your hostname 1782833837.163 sable_ircd #x1B[2m2026-06-30T15:37:17.162849Z#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: 621, tv_nsec: 386068116 }, 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 1782833837.163 sable_ircd #x1B[2m2026-06-30T15:37:17.162916Z#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 1782833837.163 sable_ircd #x1B[2m2026-06-30T15:37:17.162964Z#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 1782833837.163 sable_ircd #x1B[2m2026-06-30T15:37:17.162996Z#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" 1782833837.163 sable_ircd #x1B[2m2026-06-30T15:37:17.163063Z#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: 621, tv_nsec: 386068116 }, 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 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.163483Z#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 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.163523Z#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")) 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.163547Z#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 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.163568Z#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: 621, tv_nsec: 386068116 }, 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 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.163609Z#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)) 1782833837.164 S -> baz: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.163819Z#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(859819892960923650)), timestamp: 1782833837, clock: EventClock(1 => 859819892478578689), target: User(UserId(Snowflake(859819892960923648))), 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(859819892960923649)), NewUserConnection { user: UserId(Snowflake(859819892960923648)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833837 })) }) }; event clock=EventClock(1 => 859819892478578689) my clock=EventClock(1 => 859819892478578689) 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.163914Z#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.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164171Z#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(859819892960923650)), timestamp: 1782833837, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819892960923648)), 1) }), users_to_notify: [] }) 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164211Z#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(859819892960923650)), timestamp: 1782833837, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819892960923648)), 1) }), users_to_notify: [] } 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164271Z#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(859819892960923650)), timestamp: 1782833837, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819892960923648)), 2), connection: UserConnectionId(Snowflake(859819892960923649)) }), users_to_notify: [] }) 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164297Z#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(859819892960923650)), timestamp: 1782833837, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819892960923648)), 2), connection: UserConnectionId(Snowflake(859819892960923649)) }), users_to_notify: [] } 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164339Z#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 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164395Z#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 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164424Z#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:17.164415932 UTC 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164439Z#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 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164467Z#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 1782833837.164 sable_ircd #x1B[2m2026-06-30T15:37:17.164485Z#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 1782833837.165 sable_ircd #x1B[2m2026-06-30T15:37:17.164505Z#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 + 1782833837.165 sable_ircd #x1B[2m2026-06-30T15:37:17.164522Z#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. 1782833837.165 sable_ircd #x1B[2m2026-06-30T15:37:17.164555Z#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(859819892960923650)), timestamp: 1782833837, change: EventComplete(EventComplete), users_to_notify: [] }) 1782833837.165 sable_ircd #x1B[2m2026-06-30T15:37:17.164576Z#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(859819892960923650)), timestamp: 1782833837, change: EventComplete(EventComplete), users_to_notify: [] } 1782833837.165 S -> baz: :My.Little.Server 001 baz :Welcome to the test Internet Relay Chat network, baz 1782833837.165 baz -> S: PING foo 1782833837.165 sable_ircd #x1B[2m2026-06-30T15:37:17.165158Z#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 1782833837.165 sable_ircd #x1B[2m2026-06-30T15:37:17.165196Z#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" 1782833837.165 sable_ircd #x1B[2m2026-06-30T15:37:17.165262Z#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 1782833837.265 baz -> S: PING synchronize621.48871909 1782833837.265 S -> baz: :My.Little.Server 002 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1782833837.265 S -> baz: :My.Little.Server 003 baz :This server was created 2026-06-30 15:37:17.164415932 UTC 1782833837.265 S -> baz: :My.Little.Server 004 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1782833837.265 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 1782833837.265 S -> baz: :My.Little.Server 422 baz :MOTD File is missing 1782833837.265 S -> baz: :baz!username@localhost MODE baz + 1782833837.265 S -> baz: :My.Little.Server NOTICE baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1782833837.265 S -> baz: :My.Little.Server PONG My.Little.Server :foo 1782833837.266 sable_ircd #x1B[2m2026-06-30T15:37:17.265641Z#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 1782833837.266 sable_ircd #x1B[2m2026-06-30T15:37:17.265702Z#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 synchronize621.48871909" 1782833837.266 sable_ircd #x1B[2m2026-06-30T15:37:17.265812Z#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 :synchronize621.48871909 1782833837.266 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize621.48871909 1782833837.338 sable_history #x1B[2m2027-06-30T16:42:40.204170Z#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(992107918327488586)), timestamp: 1814373760, clock: EventClock(1 => 992090315928113159, 50 => 992107666669248585, 99 => 992090295988793346), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814373760 }) }; event clock=EventClock(1 => 992090315928113159, 50 => 992107666669248585, 99 => 992090295988793346) my clock=EventClock(1 => 992090315928113159, 50 => 992107666669248585, 99 => 992090295988793346) 1782833837.338 sable_history #x1B[2m2027-06-30T16:42:40.206542Z#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.819 sable_history #x1B[2m2027-06-30T16:42:40.675234Z#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(992107920303005770)), timestamp: 1814373760, clock: EventClock(1 => 992090370923827215, 50 => 992107668644765769, 99 => 992090360975339524), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814373760 }) }; event clock=EventClock(1 => 992090370923827215, 50 => 992107668644765769, 99 => 992090360975339524) my clock=EventClock(1 => 992090370923827215, 50 => 992107668644765769, 99 => 992090360975339524) 1782833837.819 sable_history #x1B[2m2027-06-30T16:42:40.676723Z#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.921 sable_history #x1B[2m2027-06-30T16:53:52.958058Z#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(992110740062281814)), timestamp: 1814374432, clock: EventClock(1 => 992090594522173462, 50 => 992110488404041813, 99 => 992090597802520580), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814374432 }) }; event clock=EventClock(1 => 992090594522173462, 50 => 992110488404041813, 99 => 992090597802520580) my clock=EventClock(1 => 992090594522173462, 50 => 992110488404041813, 99 => 992090597802520580) 1782833837.921 sable_history #x1B[2m2027-06-30T16:53:52.960025Z#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.967 baz -> S: OPER notanoperuser somepassword 1782833837.968 sable_ircd #x1B[2m2026-06-30T15:37:17.967626Z#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 1782833837.968 sable_ircd #x1B[2m2026-06-30T15:37:17.967696Z#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 notanoperuser somepassword" 1782833838.067 baz -> S: PING synchronize622.29087877 1782833838.068 sable_ircd #x1B[2m2026-06-30T15:37:18.067750Z#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 1782833838.068 sable_ircd #x1B[2m2026-06-30T15:37:18.067810Z#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 synchronize622.29087877" 1782833838.068 sable_ircd #x1B[2m2026-06-30T15:37:18.067924Z#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 1782833838.068 S -> baz: :My.Little.Server 491 baz :No oper configuration found 1782833838.778 sable_history #x1B[2m2027-06-30T16:56:55.473709Z#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(992111505585676377)), timestamp: 1814374615, clock: EventClock(1 => 992090797555847191, 50 => 992111253927436376, 99 => 992090799858921477), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1814374615 }) }; event clock=EventClock(1 => 992090797555847191, 50 => 992111253927436376, 99 => 992090799858921477) my clock=EventClock(1 => 992090797555847191, 50 => 992111253927436376, 99 => 992090799858921477) 1782833838.778 sable_history #x1B[2m2027-06-30T16:56:55.475314Z#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 1782833839.069 baz: waiting… 1782833839.072 sable_ircd #x1B[2m2026-06-30T15:37:19.072338Z#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 :synchronize622.29087877 1782833839.073 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize622.29087877 1782833839.076 baz: disconnects from server.