--------------------------------- Captured Out --------------------------------- ---- new test ---- 1788127989.117 sable_ircd uid=1001 1788127989.120 sable_ircd #x1B[2m2026-08-30T22:13:09.119495Z#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(882025175686582272)), timestamp: 1788127989, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127989, name: ServerName("My.Little.Server"), ts: 1788127989, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1788127989.120 sable_ircd #x1B[2m2026-08-30T22:13:09.119601Z#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 1788127989.120 sable_ircd #x1B[2m2026-08-30T22:13:09.119754Z#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(882025175686582272)), timestamp: 1788127989, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127989, name: ServerName("My.Little.Server"), ts: 1788127989, 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 1788127989.120 sable_ircd #x1B[2m2026-08-30T22:13:09.119829Z#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(882025175686582272)), timestamp: 1788127989, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1788127989.120 sable_ircd #x1B[2m2026-08-30T22:13:09.119850Z#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(882025175686582272)), timestamp: 1788127989, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1788127989.120 sable_ircd #x1B[2m2026-08-30T22:13:09.119895Z#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(882025175686582272)), timestamp: 1788127989, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127989.120 sable_ircd #x1B[2m2026-08-30T22:13:09.119913Z#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(882025175686582272)), timestamp: 1788127989, change: EventComplete(EventComplete), users_to_notify: [] } 1788127989.121 sable_ircd #x1B[2m2026-08-30T22:13:09.121269Z#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 1788127989.121 sable_ircd #x1B[2m2026-08-30T22:13:09.121344Z#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(882025175694970881)), timestamp: 1788127989, clock: EventClock(1 => 882025175686582272), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127989 }) }; event clock=EventClock(1 => 882025175686582272) my clock=EventClock(1 => 882025175686582272) 1788127989.121 sable_ircd #x1B[2m2026-08-30T22:13:09.121410Z#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 1788127989.122 sable_ircd #x1B[2m2026-08-30T22:13:09.121537Z#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(882025175694970881)), timestamp: 1788127989, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127989.122 sable_ircd #x1B[2m2026-08-30T22:13:09.121557Z#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(882025175694970881)), timestamp: 1788127989, change: EventComplete(EventComplete), users_to_notify: [] } 1788127989.213 sable_ircd #x1B[2m2026-08-30T22:13:09.213324Z#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 } 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.213475Z#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 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.213520Z#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 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.213588Z#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 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.213727Z#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 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.213770Z#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" 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.213854Z#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 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.213920Z#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)) 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.213943Z#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) 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.214288Z#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 1788127989.214 sable_ircd #x1B[2m2026-08-30T22:13:09.214347Z#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 1788127989.215 sable_ircd #x1B[2m2026-08-30T22:13:09.214518Z#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 1788127989.234 evan: connects to server. 1788127989.234 evan -> S: NICK evan 1788127989.234 evan -> S: USER username * * :Realname 1788127989.234 sable_ircd #x1B[2m2026-08-30T22:13:09.234406Z#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 } 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.234508Z#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 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.234535Z#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 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.234581Z#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 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.234681Z#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 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.234723Z#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 evan" 1788127989.235 S -> evan: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.234855Z#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: 635, tv_nsec: 356183385 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("evan")), 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 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.234916Z#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 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.234946Z#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 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.234974Z#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" 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.235033Z#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: 635, tv_nsec: 356183385 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("evan")), 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 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.235444Z#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 1788127989.235 sable_ircd #x1B[2m2026-08-30T22:13:09.235472Z#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")) 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.235491Z#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 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.235507Z#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: 635, tv_nsec: 356183385 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("evan")), 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 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.235541Z#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)) 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.235726Z#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(882025176173121538)), timestamp: 1788127989, clock: EventClock(1 => 882025175694970881), target: User(UserId(Snowflake(882025176173121536))), details: NewUser(NewUser { nickname: Nickname("evan"), 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(882025176173121537)), NewUserConnection { user: UserId(Snowflake(882025176173121536)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127989 })) }) }; event clock=EventClock(1 => 882025175694970881) my clock=EventClock(1 => 882025175694970881) 1788127989.236 S -> evan: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.235817Z#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 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236037Z#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(882025176173121538)), timestamp: 1788127989, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025176173121536)), 1) }), users_to_notify: [] }) 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236067Z#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(882025176173121538)), timestamp: 1788127989, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025176173121536)), 1) }), users_to_notify: [] } 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236113Z#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(882025176173121538)), timestamp: 1788127989, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025176173121536)), 2), connection: UserConnectionId(Snowflake(882025176173121537)) }), users_to_notify: [] }) 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236132Z#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(882025176173121538)), timestamp: 1788127989, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025176173121536)), 2), connection: UserConnectionId(Snowflake(882025176173121537)) }), users_to_notify: [] } 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236177Z#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 evan :Welcome to the test Internet Relay Chat network, evan 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236200Z#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 evan :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236226Z#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 evan :This server was created 2026-08-30 22:13:09.236216274 UTC 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236245Z#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 evan My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236281Z#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 evan 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 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236299Z#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 evan :MOTD File is missing 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236322Z#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): :evan!username@localhost MODE evan + 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236339Z#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 evan :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236398Z#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(882025176173121538)), timestamp: 1788127989, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127989.236 sable_ircd #x1B[2m2026-08-30T22:13:09.236419Z#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(882025176173121538)), timestamp: 1788127989, change: EventComplete(EventComplete), users_to_notify: [] } 1788127989.237 S -> evan: :My.Little.Server 001 evan :Welcome to the test Internet Relay Chat network, evan 1788127989.237 S -> evan: :My.Little.Server 002 evan :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127989.237 S -> evan: :My.Little.Server 003 evan :This server was created 2026-08-30 22:13:09.236216274 UTC 1788127989.237 S -> evan: :My.Little.Server 004 evan My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127989.237 S -> evan: :My.Little.Server 005 evan 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 1788127989.237 S -> evan: :My.Little.Server 422 evan :MOTD File is missing 1788127989.237 S -> evan: :evan!username@localhost MODE evan + 1788127989.237 S -> evan: :My.Little.Server NOTICE evan :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127989.237 evan -> S: PING foo 1788127989.237 sable_ircd #x1B[2m2026-08-30T22:13:09.236942Z#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 1788127989.237 sable_ircd #x1B[2m2026-08-30T22:13:09.236972Z#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" 1788127989.237 sable_ircd #x1B[2m2026-08-30T22:13:09.237023Z#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 1788127989.668 sable_ircd #x1B[2m2026-08-30T22:13:09.668261Z#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 1788127989.668 sable_ircd #x1B[2m2026-08-30T22:13:09.668302Z#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(882025177989255179)), timestamp: 1788127989, clock: EventClock(1 => 882024926331015178), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127989 }) }; event clock=EventClock(1 => 882024926331015178) my clock=EventClock(1 => 882024926331015178) 1788127989.668 sable_ircd #x1B[2m2026-08-30T22:13:09.668397Z#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 1788127989.669 sable_ircd #x1B[2m2026-08-30T22:13:09.668543Z#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(882025177989255179)), timestamp: 1788127989, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127989.669 sable_ircd #x1B[2m2026-08-30T22:13:09.668576Z#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(882025177989255179)), timestamp: 1788127989, change: EventComplete(EventComplete), users_to_notify: [] } 1788127990.038 evan -> S: PING synchronize636.159319841 1788127990.038 S -> evan: :My.Little.Server PONG My.Little.Server :foo 1788127990.038 sable_ircd #x1B[2m2026-08-30T22:13:10.038248Z#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 1788127990.038 sable_ircd #x1B[2m2026-08-30T22:13:10.038308Z#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 synchronize636.159319841" 1788127990.038 sable_ircd #x1B[2m2026-08-30T22:13:10.038452Z#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 :synchronize636.159319841 1788127990.039 S -> evan: :My.Little.Server PONG My.Little.Server :synchronize636.159319841 1788127990.039 evan -> S: MODE evan +i 1788127990.039 sable_ircd #x1B[2m2026-08-30T22:13:10.038885Z#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 1788127990.039 sable_ircd #x1B[2m2026-08-30T22:13:10.038913Z#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 evan +i" 1788127990.039 sable_ircd #x1B[2m2026-08-30T22:13:10.039112Z#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(882025179545341955)), timestamp: 1788127990, clock: EventClock(1 => 882025176173121538), target: User(UserId(Snowflake(882025176173121536))), details: UserModeChange(UserModeChange { changed_by: User(UserId(Snowflake(882025176173121536))), added: UserModeSet(1), removed: UserModeSet(0) }) }; event clock=EventClock(1 => 882025176173121538) my clock=EventClock(1 => 882025176173121538) 1788127990.039 sable_ircd #x1B[2m2026-08-30T22:13:10.039238Z#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 1788127990.039 sable_ircd #x1B[2m2026-08-30T22:13:10.039239Z#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 1788127990.040 sable_ircd #x1B[2m2026-08-30T22:13:10.039481Z#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(882025179545341955)), timestamp: 1788127990, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(882025176173121536)), 2), added: UserModeSet(1), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(882025176173121536)), 2)) }), users_to_notify: [UserId(Snowflake(882025176173121536))] }) 1788127990.040 sable_ircd #x1B[2m2026-08-30T22:13:10.039511Z#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(882025179545341955)), timestamp: 1788127990, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(882025176173121536)), 2), added: UserModeSet(1), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(882025176173121536)), 2)) }), users_to_notify: [UserId(Snowflake(882025176173121536))] } 1788127990.040 sable_ircd #x1B[2m2026-08-30T22:13:10.039556Z#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): :evan!username@localhost MODE evan +i 1788127990.040 sable_ircd #x1B[2m2026-08-30T22:13:10.039589Z#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(882025179545341955)), timestamp: 1788127990, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127990.040 sable_ircd #x1B[2m2026-08-30T22:13:10.039601Z#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(882025179545341955)), timestamp: 1788127990, change: EventComplete(EventComplete), users_to_notify: [] } 1788127990.139 evan -> S: PING synchronize636.2604556 1788127990.139 S -> evan: :evan!username@localhost MODE evan +i 1788127990.139 sable_ircd #x1B[2m2026-08-30T22:13:10.139420Z#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 1788127990.140 sable_ircd #x1B[2m2026-08-30T22:13:10.139486Z#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 synchronize636.2604556" 1788127990.712 sable_ircd #x1B[2m2026-08-30T22:13:10.711811Z#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 1788127990.712 sable_ircd #x1B[2m2026-08-30T22:13:10.711946Z#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(882025182363914251)), timestamp: 1788127990, clock: EventClock(1 => 882024930709868554), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127990 }) }; event clock=EventClock(1 => 882024930709868554) my clock=EventClock(1 => 882024930709868554) 1788127990.712 sable_ircd #x1B[2m2026-08-30T22:13:10.712020Z#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 1788127990.712 sable_ircd #x1B[2m2026-08-30T22:13:10.712157Z#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(882025182363914251)), timestamp: 1788127990, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127990.712 sable_ircd #x1B[2m2026-08-30T22:13:10.712186Z#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(882025182363914251)), timestamp: 1788127990, change: EventComplete(EventComplete), users_to_notify: [] } 1788127991.140 evan: waiting… 1788127991.144 sable_ircd #x1B[2m2026-08-30T22:13:11.143793Z#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 :synchronize636.2604556 1788127991.144 S -> evan: :My.Little.Server PONG My.Little.Server :synchronize636.2604556 1788127991.144 shivaram: connects to server. 1788127991.144 shivaram -> S: NICK shivaram 1788127991.144 shivaram -> S: USER username * * :Realname 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.144642Z#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 } 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.144723Z#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 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.144754Z#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 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.144798Z#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 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.144887Z#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 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.144917Z#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 shivaram" 1788127991.145 S -> shivaram: :My.Little.Server NOTICE * :*** Looking up your hostname 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.145027Z#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: 637, tv_nsec: 266405391 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("shivaram")), 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 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.145078Z#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 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.145099Z#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 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.145118Z#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" 1788127991.145 sable_ircd #x1B[2m2026-08-30T22:13:11.145167Z#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: 637, tv_nsec: 266405391 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("shivaram")), 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 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.145660Z#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 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.145687Z#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")) 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.145713Z#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 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.145731Z#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: 637, tv_nsec: 266405391 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("shivaram")), 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 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.145775Z#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)) 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.145966Z#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(882025184184242180)), timestamp: 1788127991, clock: EventClock(1 => 882025179545341955), target: User(UserId(Snowflake(882025184184242178))), details: NewUser(NewUser { nickname: Nickname("shivaram"), 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(882025184184242179)), NewUserConnection { user: UserId(Snowflake(882025184184242178)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127991 })) }) }; event clock=EventClock(1 => 882025179545341955) my clock=EventClock(1 => 882025179545341955) 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146043Z#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 1788127991.146 S -> shivaram: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146268Z#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(882025184184242180)), timestamp: 1788127991, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025184184242178)), 1) }), users_to_notify: [] }) 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146300Z#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(882025184184242180)), timestamp: 1788127991, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025184184242178)), 1) }), users_to_notify: [] } 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146338Z#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(882025184184242180)), timestamp: 1788127991, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025184184242178)), 2), connection: UserConnectionId(Snowflake(882025184184242179)) }), users_to_notify: [] }) 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146352Z#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(882025184184242180)), timestamp: 1788127991, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025184184242178)), 2), connection: UserConnectionId(Snowflake(882025184184242179)) }), users_to_notify: [] } 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146401Z#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 shivaram :Welcome to the test Internet Relay Chat network, shivaram 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146419Z#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 shivaram :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146433Z#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 shivaram :This server was created 2026-08-30 22:13:11.146427542 UTC 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146444Z#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 shivaram My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146457Z#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 shivaram 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 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146468Z#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 shivaram :MOTD File is missing 1788127991.146 sable_ircd #x1B[2m2026-08-30T22:13:11.146481Z#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): :shivaram!username@localhost MODE shivaram + 1788127991.147 sable_ircd #x1B[2m2026-08-30T22:13:11.146490Z#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 shivaram :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127991.147 sable_ircd #x1B[2m2026-08-30T22:13:11.146517Z#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(882025184184242180)), timestamp: 1788127991, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127991.147 sable_ircd #x1B[2m2026-08-30T22:13:11.146529Z#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(882025184184242180)), timestamp: 1788127991, change: EventComplete(EventComplete), users_to_notify: [] } 1788127991.147 S -> shivaram: :My.Little.Server 001 shivaram :Welcome to the test Internet Relay Chat network, shivaram 1788127991.147 shivaram -> S: PING foo 1788127991.147 sable_ircd #x1B[2m2026-08-30T22:13:11.146888Z#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 1788127991.147 sable_ircd #x1B[2m2026-08-30T22:13:11.146916Z#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" 1788127991.147 sable_ircd #x1B[2m2026-08-30T22:13:11.146966Z#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 1788127991.247 shivaram -> S: PING synchronize637.368462144 1788127991.247 S -> shivaram: :My.Little.Server 002 shivaram :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1788127991.247 S -> shivaram: :My.Little.Server 003 shivaram :This server was created 2026-08-30 22:13:11.146427542 UTC 1788127991.247 S -> shivaram: :My.Little.Server 004 shivaram My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1788127991.247 S -> shivaram: :My.Little.Server 005 shivaram 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 1788127991.247 S -> shivaram: :My.Little.Server 422 shivaram :MOTD File is missing 1788127991.247 S -> shivaram: :shivaram!username@localhost MODE shivaram + 1788127991.247 S -> shivaram: :My.Little.Server NOTICE shivaram :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1788127991.247 S -> shivaram: :My.Little.Server PONG My.Little.Server :foo 1788127991.247 sable_ircd #x1B[2m2026-08-30T22:13:11.247236Z#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 1788127991.247 sable_ircd #x1B[2m2026-08-30T22:13:11.247289Z#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 synchronize637.368462144" 1788127991.247 sable_ircd #x1B[2m2026-08-30T22:13:11.247414Z#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 :synchronize637.368462144 1788127991.248 S -> shivaram: :My.Little.Server PONG My.Little.Server :synchronize637.368462144 1788127991.644 sable_ircd #x1B[2m2026-08-30T22:13:11.643755Z#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 1788127991.644 sable_ircd #x1B[2m2026-08-30T22:13:11.643770Z#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(882025186273005579)), timestamp: 1788127991, clock: EventClock(1 => 882024934614765578), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127991 }) }; event clock=EventClock(1 => 882024934614765578) my clock=EventClock(1 => 882024934614765578) 1788127991.644 sable_ircd #x1B[2m2026-08-30T22:13:11.643837Z#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 1788127991.644 sable_ircd #x1B[2m2026-08-30T22:13:11.643969Z#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(882025186273005579)), timestamp: 1788127991, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127991.644 sable_ircd #x1B[2m2026-08-30T22:13:11.643993Z#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(882025186273005579)), timestamp: 1788127991, change: EventComplete(EventComplete), users_to_notify: [] } 1788127992.049 shivaram -> S: PING synchronize638.170183852 1788127992.049 sable_ircd #x1B[2m2026-08-30T22:13:12.048988Z#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 1788127992.049 sable_ircd #x1B[2m2026-08-30T22:13:12.049043Z#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 synchronize638.170183852" 1788127992.049 sable_ircd #x1B[2m2026-08-30T22:13:12.049150Z#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 :synchronize638.170183852 1788127992.049 S -> shivaram: :My.Little.Server PONG My.Little.Server :synchronize638.170183852 1788127992.049 shivaram -> S: WHO eva* 1788127992.050 sable_ircd #x1B[2m2026-08-30T22:13:12.049608Z#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 1788127992.050 sable_ircd #x1B[2m2026-08-30T22:13:12.049639Z#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"WHO eva*" 1788127992.150 shivaram -> S: PING synchronize638.271164415 1788127992.150 sable_ircd #x1B[2m2026-08-30T22:13:12.149961Z#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 1788127992.150 sable_ircd #x1B[2m2026-08-30T22:13:12.150009Z#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 synchronize638.271164415" 1788127992.828 sable_ircd #x1B[2m2026-08-30T22:13:12.827756Z#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 1788127992.828 sable_ircd #x1B[2m2026-08-30T22:13:12.827835Z#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(882025191239061515)), timestamp: 1788127992, clock: EventClock(1 => 882024939576627210), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127992 }) }; event clock=EventClock(1 => 882024939576627210) my clock=EventClock(1 => 882024939576627210) 1788127992.828 sable_ircd #x1B[2m2026-08-30T22:13:12.827910Z#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 1788127992.828 sable_ircd #x1B[2m2026-08-30T22:13:12.828075Z#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(882025191239061515)), timestamp: 1788127992, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127992.828 sable_ircd #x1B[2m2026-08-30T22:13:12.828104Z#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(882025191239061515)), timestamp: 1788127992, change: EventComplete(EventComplete), users_to_notify: [] } 1788127993.151 shivaram: waiting… 1788127993.154 sable_ircd #x1B[2m2026-08-30T22:13:13.154246Z#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 315 shivaram eva* :End of /WHO list 1788127993.155 S -> shivaram: :My.Little.Server 315 shivaram eva* :End of /WHO list 1788127994.155 shivaram: waiting… 1788127994.160 sable_ircd #x1B[2m2026-08-30T22:13:14.159502Z#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 :synchronize638.271164415 1788127994.160 S -> shivaram: :My.Little.Server PONG My.Little.Server :synchronize638.271164415 1788127994.160 shivaram -> S: WHO evan 1788127994.160 sable_ircd #x1B[2m2026-08-30T22:13:14.160224Z#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 1788127994.160 sable_ircd #x1B[2m2026-08-30T22:13:14.160259Z#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"WHO evan" 1788127994.260 shivaram -> S: PING synchronize640.381736584 1788127994.261 sable_ircd #x1B[2m2026-08-30T22:13:14.260547Z#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 1788127994.261 sable_ircd #x1B[2m2026-08-30T22:13:14.260597Z#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 synchronize640.381736584" 1788127995.015 sable_ircd #x1B[2m2026-08-30T22:13:15.014498Z#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 352 shivaram * username localhost * evan H :0 Realname 1788127995.015 sable_ircd #x1B[2m2026-08-30T22:13:15.014554Z#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 315 shivaram evan :End of /WHO list 1788127995.015 S -> shivaram: :My.Little.Server 352 shivaram * username localhost * evan H :0 Realname 1788127995.055 S -> shivaram: :My.Little.Server 315 shivaram evan :End of /WHO list 1788127996.019 sable_ircd #x1B[2m2026-08-30T22:13:16.018908Z#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 :synchronize640.381736584 1788127996.019 S -> shivaram: :My.Little.Server PONG My.Little.Server :synchronize640.381736584 1788127996.020 evan -> S: JOIN #test 1788127996.020 sable_ircd #x1B[2m2026-08-30T22:13:16.019725Z#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 1788127996.020 sable_ircd #x1B[2m2026-08-30T22:13:16.019770Z#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 #test" 1788127996.020 sable_ircd #x1B[2m2026-08-30T22:13:16.019977Z#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(882025204627279877)), timestamp: 1788127996, clock: EventClock(1 => 882025184184242180), target: Channel(ChannelId(Snowflake(882025204627279876))), details: NewChannel(NewChannel { name: ChannelName("#test"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 882025184184242180) my clock=EventClock(1 => 882025184184242180) 1788127996.020 sable_ircd #x1B[2m2026-08-30T22:13:16.020101Z#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 1788127996.020 sable_ircd #x1B[2m2026-08-30T22:13:16.020163Z#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(882025204631474182)), timestamp: 1788127996, clock: EventClock(1 => 882025204627279877), target: Membership(MembershipId(UserId(Snowflake(882025176173121536)), ChannelId(Snowflake(882025204627279876)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882025204627279876)), user: UserId(Snowflake(882025176173121536)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 882025204627279877) my clock=EventClock(1 => 882025204627279877) 1788127996.020 sable_ircd #x1B[2m2026-08-30T22:13:16.020247Z#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 1788127996.020 sable_ircd #x1B[2m2026-08-30T22:13:16.020267Z#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 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020470Z#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(882025204627279877)), timestamp: 1788127996, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020495Z#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(882025204627279877)), timestamp: 1788127996, change: EventComplete(EventComplete), users_to_notify: [] } 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020524Z#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(882025204631474182)), timestamp: 1788127996, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025176173121536)), ChannelId(Snowflake(882025204627279876))), user: HistoricUserId(UserId(Snowflake(882025176173121536)), 2) }), users_to_notify: [UserId(Snowflake(882025176173121536))] }) 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020539Z#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(882025204631474182)), timestamp: 1788127996, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025176173121536)), ChannelId(Snowflake(882025204627279876))), user: HistoricUserId(UserId(Snowflake(882025176173121536)), 2) }), users_to_notify: [UserId(Snowflake(882025176173121536))] } 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020583Z#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): :evan!username@localhost JOIN #test 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020606Z#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): :evan!username@localhost MODE #test +o evan 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020634Z#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 evan = #test :@evan 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020646Z#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 evan #test :End of names list 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020670Z#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(882025204631474182)), timestamp: 1788127996, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127996.021 sable_ircd #x1B[2m2026-08-30T22:13:16.020682Z#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(882025204631474182)), timestamp: 1788127996, change: EventComplete(EventComplete), users_to_notify: [] } 1788127996.120 evan -> S: PING synchronize642.241257444 1788127996.120 S -> evan: :evan!username@localhost JOIN #test 1788127996.120 S -> evan: :evan!username@localhost MODE #test +o evan 1788127996.120 S -> evan: :My.Little.Server 353 evan = #test :@evan 1788127996.120 S -> evan: :My.Little.Server 366 evan #test :End of names list 1788127996.120 sable_ircd #x1B[2m2026-08-30T22:13:16.120025Z#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 1788127996.120 sable_ircd #x1B[2m2026-08-30T22:13:16.120096Z#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 synchronize642.241257444" 1788127996.120 sable_ircd #x1B[2m2026-08-30T22:13:16.120200Z#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 :synchronize642.241257444 1788127996.120 S -> evan: :My.Little.Server PONG My.Little.Server :synchronize642.241257444 1788127996.120 shivaram -> S: JOIN #test 1788127996.121 sable_ircd #x1B[2m2026-08-30T22:13:16.120657Z#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 1788127996.121 sable_ircd #x1B[2m2026-08-30T22:13:16.120691Z#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"JOIN #test" 1788127996.221 shivaram -> S: PING synchronize642.342232869 1788127996.221 sable_ircd #x1B[2m2026-08-30T22:13:16.221064Z#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 1788127996.221 sable_ircd #x1B[2m2026-08-30T22:13:16.221118Z#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 synchronize642.342232869" 1788127997.222 shivaram: waiting… 1788127997.226 sable_ircd #x1B[2m2026-08-30T22:13:17.226268Z#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(882025209689804807)), timestamp: 1788127997, clock: EventClock(1 => 882025204631474182), target: Membership(MembershipId(UserId(Snowflake(882025184184242178)), ChannelId(Snowflake(882025204627279876)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882025204627279876)), user: UserId(Snowflake(882025184184242178)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882025204631474182) my clock=EventClock(1 => 882025204631474182) 1788127997.226 sable_ircd #x1B[2m2026-08-30T22:13:17.226402Z#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 1788127997.226 sable_ircd #x1B[2m2026-08-30T22:13:17.226406Z#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 1788127997.227 sable_ircd #x1B[2m2026-08-30T22:13:17.226580Z#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(882025209689804807)), timestamp: 1788127997, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025184184242178)), ChannelId(Snowflake(882025204627279876))), user: HistoricUserId(UserId(Snowflake(882025184184242178)), 2) }), users_to_notify: [UserId(Snowflake(882025184184242178)), UserId(Snowflake(882025176173121536))] }) 1788127997.227 sable_ircd #x1B[2m2026-08-30T22:13:17.226609Z#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(882025209689804807)), timestamp: 1788127997, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025184184242178)), ChannelId(Snowflake(882025204627279876))), user: HistoricUserId(UserId(Snowflake(882025184184242178)), 2) }), users_to_notify: [UserId(Snowflake(882025184184242178)), UserId(Snowflake(882025176173121536))] } 1788127997.227 sable_ircd #x1B[2m2026-08-30T22:13:17.226654Z#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): :shivaram!username@localhost JOIN #test 1788127997.227 sable_ircd #x1B[2m2026-08-30T22:13:17.226689Z#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 353 shivaram = #test :shivaram @evan 1788127997.227 sable_ircd #x1B[2m2026-08-30T22:13:17.226701Z#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 366 shivaram #test :End of names list 1788127997.227 sable_ircd #x1B[2m2026-08-30T22:13:17.226714Z#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): :shivaram!username@localhost JOIN #test 1788127997.227 sable_ircd #x1B[2m2026-08-30T22:13:17.226735Z#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(882025209689804807)), timestamp: 1788127997, change: EventComplete(EventComplete), users_to_notify: [] }) 1788127997.227 sable_ircd #x1B[2m2026-08-30T22:13:17.226747Z#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(882025209689804807)), timestamp: 1788127997, change: EventComplete(EventComplete), users_to_notify: [] } 1788127997.227 S -> shivaram: :shivaram!username@localhost JOIN #test 1788127997.227 S -> shivaram: :My.Little.Server 353 shivaram = #test :shivaram @evan 1788127997.227 S -> shivaram: :My.Little.Server 366 shivaram #test :End of names list 1788127998.228 shivaram: waiting… 1788127998.231 sable_ircd #x1B[2m2026-08-30T22:13:18.231203Z#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 :synchronize642.342232869 1788127998.232 S -> shivaram: :My.Little.Server PONG My.Little.Server :synchronize642.342232869 1788127998.232 shivaram -> S: WHO eva* 1788127998.233 sable_ircd #x1B[2m2026-08-30T22:13:18.232812Z#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 1788127998.233 sable_ircd #x1B[2m2026-08-30T22:13:18.232850Z#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"WHO eva*" 1788127998.332 shivaram -> S: PING synchronize644.45391007 1788127998.333 sable_ircd #x1B[2m2026-08-30T22:13:18.332731Z#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 1788127998.333 sable_ircd #x1B[2m2026-08-30T22:13:18.332785Z#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 synchronize644.45391007" 1788127999.088 sable_ircd #x1B[2m2026-08-30T22:13:19.087610Z#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 352 shivaram * username localhost * evan H :0 Realname 1788127999.088 sable_ircd #x1B[2m2026-08-30T22:13:19.087667Z#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 315 shivaram eva* :End of /WHO list 1788127999.088 S -> shivaram: :My.Little.Server 352 shivaram * username localhost * evan H :0 Realname 1788127999.128 S -> shivaram: :My.Little.Server 315 shivaram eva* :End of /WHO list 1788128000.094 sable_ircd #x1B[2m2026-08-30T22:13:20.094121Z#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 :synchronize644.45391007 1788128000.095 S -> shivaram: :My.Little.Server PONG My.Little.Server :synchronize644.45391007 1788128000.097 evan: disconnects from server. 1788128000.098 shivaram: disconnects from server.