--------------------------------- Captured Out --------------------------------- ---- new test ---- 1787482776.216 sable_ircd uid=1001 1787482776.219 sable_ircd #x1B[2m2026-08-23T10:59:36.218855Z#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(879318956635066368)), timestamp: 1787482776, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1787482776, name: ServerName("My.Little.Server"), ts: 1787482776, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1787482776.219 sable_ircd #x1B[2m2026-08-23T10:59:36.218970Z#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 1787482776.219 sable_ircd #x1B[2m2026-08-23T10:59:36.219146Z#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(879318956635066368)), timestamp: 1787482776, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1787482776, name: ServerName("My.Little.Server"), ts: 1787482776, 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 1787482776.219 sable_ircd #x1B[2m2026-08-23T10:59:36.219210Z#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(879318956635066368)), timestamp: 1787482776, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1787482776.219 sable_ircd #x1B[2m2026-08-23T10:59:36.219226Z#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(879318956635066368)), timestamp: 1787482776, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1787482776.219 sable_ircd #x1B[2m2026-08-23T10:59:36.219251Z#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(879318956635066368)), timestamp: 1787482776, change: EventComplete(EventComplete), users_to_notify: [] }) 1787482776.219 sable_ircd #x1B[2m2026-08-23T10:59:36.219260Z#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(879318956635066368)), timestamp: 1787482776, change: EventComplete(EventComplete), users_to_notify: [] } 1787482776.220 sable_ircd #x1B[2m2026-08-23T10:59:36.220178Z#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 1787482776.220 sable_ircd #x1B[2m2026-08-23T10:59:36.220204Z#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(879318956643454977)), timestamp: 1787482776, clock: EventClock(1 => 879318956635066368), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1787482776 }) }; event clock=EventClock(1 => 879318956635066368) my clock=EventClock(1 => 879318956635066368) 1787482776.220 sable_ircd #x1B[2m2026-08-23T10:59:36.220288Z#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 1787482776.220 sable_ircd #x1B[2m2026-08-23T10:59:36.220447Z#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(879318956643454977)), timestamp: 1787482776, change: EventComplete(EventComplete), users_to_notify: [] }) 1787482776.220 sable_ircd #x1B[2m2026-08-23T10:59:36.220480Z#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(879318956643454977)), timestamp: 1787482776, change: EventComplete(EventComplete), users_to_notify: [] } 1787482776.313 sable_ircd #x1B[2m2026-08-23T10:59:36.312458Z#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 } 1787482776.313 sable_ircd #x1B[2m2026-08-23T10:59:36.312602Z#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 1787482776.313 sable_ircd #x1B[2m2026-08-23T10:59:36.312647Z#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 1787482776.313 sable_ircd #x1B[2m2026-08-23T10:59:36.312724Z#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 1787482776.313 sable_ircd #x1B[2m2026-08-23T10:59:36.312863Z#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 1787482776.313 sable_ircd #x1B[2m2026-08-23T10:59:36.312903Z#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" 1787482776.313 sable_ircd #x1B[2m2026-08-23T10:59:36.312992Z#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 1787482776.313 sable_ircd #x1B[2m2026-08-23T10:59:36.313061Z#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)) 1787482776.313 sable_ircd #x1B[2m2026-08-23T10:59:36.313082Z#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) 1787482776.314 sable_ircd #x1B[2m2026-08-23T10:59:36.313572Z#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 1787482776.314 sable_ircd #x1B[2m2026-08-23T10:59:36.313687Z#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 1787482776.314 sable_ircd #x1B[2m2026-08-23T10:59:36.313869Z#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 1787482776.334 1: connects to server. 1787482776.334 1 -> S: NICK nick1 1787482776.334 1 -> S: USER username * * :Realname 1787482776.334 sable_ircd #x1B[2m2026-08-23T10:59:36.333964Z#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 } 1787482776.334 sable_ircd #x1B[2m2026-08-23T10:59:36.334094Z#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 1787482776.334 sable_ircd #x1B[2m2026-08-23T10:59:36.334139Z#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 1787482776.334 sable_ircd #x1B[2m2026-08-23T10:59:36.334200Z#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 1787482776.334 sable_ircd #x1B[2m2026-08-23T10:59:36.334349Z#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 1787482776.334 sable_ircd #x1B[2m2026-08-23T10:59:36.334410Z#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 nick1" 1787482776.335 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1787482776.335 sable_ircd #x1B[2m2026-08-23T10:59:36.334517Z#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 1787482776.335 sable_ircd #x1B[2m2026-08-23T10:59:36.334551Z#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" 1787482776.335 sable_ircd #x1B[2m2026-08-23T10:59:36.334631Z#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: 542, tv_nsec: 246800853 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(), 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 1787482776.335 sable_ircd #x1B[2m2026-08-23T10:59:36.334749Z#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: 542, tv_nsec: 246800853 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick1")), 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 1787482776.335 sable_ircd #x1B[2m2026-08-23T10:59:36.334808Z#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 1787482776.335 sable_ircd #x1B[2m2026-08-23T10:59:36.335323Z#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 1787482776.335 sable_ircd #x1B[2m2026-08-23T10:59:36.335391Z#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")) 1787482776.335 sable_ircd #x1B[2m2026-08-23T10:59:36.335451Z#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 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.335478Z#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: 542, tv_nsec: 246800853 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick1")), 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 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.335532Z#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)) 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.335774Z#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(879318957125799938)), timestamp: 1787482776, clock: EventClock(1 => 879318956643454977), target: User(UserId(Snowflake(879318957125799936))), details: NewUser(NewUser { nickname: Nickname("nick1"), 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(879318957125799937)), NewUserConnection { user: UserId(Snowflake(879318957125799936)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1787482776 })) }) }; event clock=EventClock(1 => 879318956643454977) my clock=EventClock(1 => 879318956643454977) 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.335868Z#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 1787482776.336 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336130Z#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(879318957125799938)), timestamp: 1787482776, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(879318957125799936)), 1) }), users_to_notify: [] }) 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336168Z#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(879318957125799938)), timestamp: 1787482776, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(879318957125799936)), 1) }), users_to_notify: [] } 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336211Z#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(879318957125799938)), timestamp: 1787482776, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(879318957125799936)), 2), connection: UserConnectionId(Snowflake(879318957125799937)) }), users_to_notify: [] }) 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336228Z#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(879318957125799938)), timestamp: 1787482776, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(879318957125799936)), 2), connection: UserConnectionId(Snowflake(879318957125799937)) }), users_to_notify: [] } 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336283Z#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 nick1 :Welcome to the test Internet Relay Chat network, nick1 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336310Z#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 nick1 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336337Z#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 nick1 :This server was created 2026-08-23 10:59:36.336325689 UTC 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336358Z#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 nick1 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336413Z#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 nick1 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 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336435Z#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 nick1 :MOTD File is missing 1787482776.336 sable_ircd #x1B[2m2026-08-23T10:59:36.336459Z#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): :nick1!username@localhost MODE nick1 + 1787482776.337 sable_ircd #x1B[2m2026-08-23T10:59:36.336478Z#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 nick1 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1787482776.337 sable_ircd #x1B[2m2026-08-23T10:59:36.336517Z#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(879318957125799938)), timestamp: 1787482776, change: EventComplete(EventComplete), users_to_notify: [] }) 1787482776.337 sable_ircd #x1B[2m2026-08-23T10:59:36.336535Z#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(879318957125799938)), timestamp: 1787482776, change: EventComplete(EventComplete), users_to_notify: [] } 1787482776.337 S -> 1: :My.Little.Server 001 nick1 :Welcome to the test Internet Relay Chat network, nick1 1787482776.337 1 -> S: PING foo 1787482776.337 sable_ircd #x1B[2m2026-08-23T10:59:36.337002Z#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 1787482776.337 sable_ircd #x1B[2m2026-08-23T10:59:36.337041Z#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" 1787482776.337 sable_ircd #x1B[2m2026-08-23T10:59:36.337114Z#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 1787482776.401 sable_history #x1B[2m2027-08-23T12:31:06.727181Z#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(1011613556438933605)), timestamp: 1819024266, clock: EventClock(1 => 1011588884229787649, 50 => 1011613304780693604), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024266 }) }; event clock=EventClock(1 => 1011588884229787649, 50 => 1011613304780693604) my clock=EventClock(1 => 1011588884229787649, 50 => 1011613304780693604) 1787482776.401 sable_history #x1B[2m2027-08-23T12:31:06.728974Z#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 1787482776.437 1 -> S: PING synchronize542.349562993 1787482776.437 S -> 1: :My.Little.Server 002 nick1 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1787482776.437 S -> 1: :My.Little.Server 003 nick1 :This server was created 2026-08-23 10:59:36.336325689 UTC 1787482776.437 S -> 1: :My.Little.Server 004 nick1 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1787482776.437 S -> 1: :My.Little.Server 005 nick1 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 1787482776.437 S -> 1: :My.Little.Server 422 nick1 :MOTD File is missing 1787482776.437 S -> 1: :nick1!username@localhost MODE nick1 + 1787482776.437 S -> 1: :My.Little.Server NOTICE nick1 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1787482776.437 S -> 1: :My.Little.Server PONG My.Little.Server :foo 1787482776.438 sable_ircd #x1B[2m2026-08-23T10:59:36.437564Z#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 1787482776.438 sable_ircd #x1B[2m2026-08-23T10:59:36.437632Z#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 synchronize542.349562993" 1787482776.438 sable_ircd #x1B[2m2026-08-23T10:59:36.437771Z#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 :synchronize542.349562993 1787482776.438 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize542.349562993 1787482776.451 sable_history #x1B[2m2027-08-23T12:42:38.231770Z#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(1011616456821121138)), timestamp: 1819024958, clock: EventClock(1 => 1011589432517595159, 50 => 1011616204999303281, 99 => 1011589436825546757), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024958 }) }; event clock=EventClock(1 => 1011589432517595159, 50 => 1011616204999303281, 99 => 1011589436825546757) my clock=EventClock(1 => 1011589432517595159, 50 => 1011616204999303281, 99 => 1011589436825546757) 1787482776.451 sable_history #x1B[2m2027-08-23T12:42:38.233132Z#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 1787482776.772 sable_history #x1B[2m2027-08-23T12:31:06.873995Z#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(1011613557055496294)), timestamp: 1819024266, clock: EventClock(1 => 1011588957751742479, 50 => 1011613305401450597, 99 => 1011588947811643396), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024266 }) }; event clock=EventClock(1 => 1011588957751742479, 50 => 1011613305401450597, 99 => 1011588947811643396) my clock=EventClock(1 => 1011588957751742479, 50 => 1011613305401450597, 99 => 1011588947811643396) 1787482776.772 sable_history #x1B[2m2027-08-23T12:31:06.875648Z#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 1787482777.139 2: connects to server. 1787482777.139 2 -> S: NICK nick2 1787482777.139 2 -> S: USER username * * :Realname 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.139502Z#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 } 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.139647Z#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 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.139694Z#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 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.139776Z#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 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.139957Z#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 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.140002Z#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 nick2" 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.140121Z#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: 543, tv_nsec: 52364463 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("nick2")), 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 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.140168Z#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 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.140204Z#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 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.140243Z#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" 1787482777.140 sable_ircd #x1B[2m2026-08-23T10:59:37.140303Z#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: 543, tv_nsec: 52364463 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick2")), 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 1787482777.141 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname 1787482777.141 sable_ircd #x1B[2m2026-08-23T10:59:37.140970Z#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 1787482777.141 sable_ircd #x1B[2m2026-08-23T10:59:37.141009Z#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")) 1787482777.141 sable_ircd #x1B[2m2026-08-23T10:59:37.141042Z#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 1787482777.141 sable_ircd #x1B[2m2026-08-23T10:59:37.141065Z#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: 543, tv_nsec: 52364463 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick2")), 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 1787482777.141 sable_ircd #x1B[2m2026-08-23T10:59:37.141121Z#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)) 1787482777.141 sable_ircd #x1B[2m2026-08-23T10:59:37.141337Z#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(879318960506408963)), timestamp: 1787482777, clock: EventClock(1 => 879318957125799938), target: User(UserId(Snowflake(879318960506408962))), details: NewUser(NewUser { nickname: Nickname("nick2"), 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(879318960506408963)), NewUserConnection { user: UserId(Snowflake(879318960506408962)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1787482777 })) }) }; event clock=EventClock(1 => 879318957125799938) my clock=EventClock(1 => 879318957125799938) 1787482777.141 sable_ircd #x1B[2m2026-08-23T10:59:37.141456Z#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 1787482777.142 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.141734Z#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(879318960506408963)), timestamp: 1787482777, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(879318960506408962)), 1) }), users_to_notify: [] }) 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.141775Z#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(879318960506408963)), timestamp: 1787482777, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(879318960506408962)), 1) }), users_to_notify: [] } 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.141845Z#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(879318960506408963)), timestamp: 1787482777, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(879318960506408962)), 2), connection: UserConnectionId(Snowflake(879318960506408963)) }), users_to_notify: [] }) 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.141867Z#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(879318960506408963)), timestamp: 1787482777, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(879318960506408962)), 2), connection: UserConnectionId(Snowflake(879318960506408963)) }), users_to_notify: [] } 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.141946Z#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 nick2 :Welcome to the test Internet Relay Chat network, nick2 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.141976Z#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 nick2 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.142020Z#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 nick2 :This server was created 2026-08-23 10:59:37.141993532 UTC 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.142045Z#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 nick2 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.142082Z#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 nick2 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 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.142115Z#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 nick2 :MOTD File is missing 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.142156Z#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): :nick2!username@localhost MODE nick2 + 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.142179Z#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 nick2 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.142229Z#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(879318960506408963)), timestamp: 1787482777, change: EventComplete(EventComplete), users_to_notify: [] }) 1787482777.142 sable_ircd #x1B[2m2026-08-23T10:59:37.142250Z#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(879318960506408963)), timestamp: 1787482777, change: EventComplete(EventComplete), users_to_notify: [] } 1787482777.143 S -> 2: :My.Little.Server 001 nick2 :Welcome to the test Internet Relay Chat network, nick2 1787482777.143 S -> 2: :My.Little.Server 002 nick2 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1787482777.143 S -> 2: :My.Little.Server 003 nick2 :This server was created 2026-08-23 10:59:37.141993532 UTC 1787482777.143 S -> 2: :My.Little.Server 004 nick2 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1787482777.143 S -> 2: :My.Little.Server 005 nick2 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 1787482777.143 S -> 2: :My.Little.Server 422 nick2 :MOTD File is missing 1787482777.143 S -> 2: :nick2!username@localhost MODE nick2 + 1787482777.143 S -> 2: :My.Little.Server NOTICE nick2 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1787482777.143 2 -> S: PING foo 1787482777.143 sable_ircd #x1B[2m2026-08-23T10:59:37.142873Z#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 1787482777.143 sable_ircd #x1B[2m2026-08-23T10:59:37.142918Z#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" 1787482777.143 sable_ircd #x1B[2m2026-08-23T10:59:37.143018Z#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 1787482777.944 2 -> S: PING synchronize543.85631922 1787482777.944 S -> 2: :My.Little.Server PONG My.Little.Server :foo 1787482777.944 sable_ircd #x1B[2m2026-08-23T10:59:37.944321Z#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 1787482777.944 sable_ircd #x1B[2m2026-08-23T10:59:37.944413Z#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 synchronize543.85631922" 1787482777.945 sable_ircd #x1B[2m2026-08-23T10:59:37.944561Z#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 :synchronize543.85631922 1787482777.945 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize543.85631922 1787482777.945 3: connects to server. 1787482777.945 3 -> S: NICK nick3 1787482777.945 3 -> S: USER username * * :Realname 1787482777.945 sable_ircd #x1B[2m2026-08-23T10:59:37.945373Z#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), 4), remote_addr: 127.0.0.1, tls_info: None } 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.945515Z#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 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.945550Z#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), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.945616Z#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), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Looking up your hostname 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.945751Z#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 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.945783Z#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), 4)#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 nick3" 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.945869Z#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 1787482777.946 S -> 3: :My.Little.Server NOTICE * :*** Looking up your hostname 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.945924Z#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), 4)#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" 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.946009Z#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: 543, tv_nsec: 858214353 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(), 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 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.946108Z#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: 543, tv_nsec: 858214353 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick3")), 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 1787482777.946 sable_ircd #x1B[2m2026-08-23T10:59:37.946149Z#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 1787482777.947 sable_ircd #x1B[2m2026-08-23T10:59:37.946747Z#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 1787482777.947 sable_ircd #x1B[2m2026-08-23T10:59:37.946784Z#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), 4): 127.0.0.1/Some(Hostname("localhost")) 1787482777.947 sable_ircd #x1B[2m2026-08-23T10:59:37.946820Z#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), 4): :My.Little.Server NOTICE * :*** Found your hostname: localhost 1787482777.947 sable_ircd #x1B[2m2026-08-23T10:59:37.946845Z#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: 543, tv_nsec: 858214353 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick3")), 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 1787482777.947 sable_ircd #x1B[2m2026-08-23T10:59:37.946893Z#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), 4)) 1787482777.947 sable_ircd #x1B[2m2026-08-23T10:59:37.947114Z#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(879318963887017988)), timestamp: 1787482777, clock: EventClock(1 => 879318960506408963), target: User(UserId(Snowflake(879318963882823684))), details: NewUser(NewUser { nickname: Nickname("nick3"), 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(879318963882823685)), NewUserConnection { user: UserId(Snowflake(879318963882823684)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1787482777 })) }) }; event clock=EventClock(1 => 879318960506408963) my clock=EventClock(1 => 879318960506408963) 1787482777.947 S -> 3: :My.Little.Server NOTICE * :*** Found your hostname: localhost1787482777.947 sable_ircd #x1B[2m2026-08-23T10:59:37.947198Z#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 1787482777.947 sable_ircd #x1B[2m2026-08-23T10:59:37.947450Z#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(879318963887017988)), timestamp: 1787482777, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(879318963882823684)), 1) }), users_to_notify: [] }) 1787482777.947 sable_ircd #x1B[2m2026-08-23T10:59:37.947484Z#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(879318963887017988)), timestamp: 1787482777, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(879318963882823684)), 1) }), users_to_notify: [] } 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947531Z#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(879318963887017988)), timestamp: 1787482777, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(879318963882823684)), 2), connection: UserConnectionId(Snowflake(879318963882823685)) }), users_to_notify: [] }) 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947547Z#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(879318963887017988)), timestamp: 1787482777, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(879318963882823684)), 2), connection: UserConnectionId(Snowflake(879318963882823685)) }), users_to_notify: [] } 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947593Z#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), 4): :My.Little.Server 001 nick3 :Welcome to the test Internet Relay Chat network, nick3 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947613Z#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), 4): :My.Little.Server 002 nick3 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947641Z#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), 4): :My.Little.Server 003 nick3 :This server was created 2026-08-23 10:59:37.947630165 UTC 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947661Z#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), 4): :My.Little.Server 004 nick3 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947686Z#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), 4): :My.Little.Server 005 nick3 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 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947706Z#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), 4): :My.Little.Server 422 nick3 :MOTD File is missing 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947728Z#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), 4): :nick3!username@localhost MODE nick3 + 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947746Z#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), 4): :My.Little.Server NOTICE nick3 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947770Z#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(879318963887017988)), timestamp: 1787482777, change: EventComplete(EventComplete), users_to_notify: [] }) 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.947787Z#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(879318963887017988)), timestamp: 1787482777, change: EventComplete(EventComplete), users_to_notify: [] } 1787482777.948 S -> 3: :My.Little.Server 001 nick3 :Welcome to the test Internet Relay Chat network, nick3 1787482777.948 S -> 3: :My.Little.Server 002 nick3 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1787482777.948 3 -> S: PING foo 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.948217Z#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 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.948251Z#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), 4)#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" 1787482777.948 sable_ircd #x1B[2m2026-08-23T10:59:37.948314Z#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), 4): :My.Little.Server PONG My.Little.Server :foo 1787482778.148 3 -> S: PING synchronize544.060869076 1787482778.148 S -> 3: :My.Little.Server 003 nick3 :This server was created 2026-08-23 10:59:37.947630165 UTC 1787482778.148 S -> 3: :My.Little.Server 004 nick3 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1787482778.148 S -> 3: :My.Little.Server 005 nick3 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 1787482778.148 S -> 3: :My.Little.Server 422 nick3 :MOTD File is missing 1787482778.148 S -> 3: :nick3!username@localhost MODE nick3 + 1787482778.148 S -> 3: :My.Little.Server NOTICE nick3 :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1787482778.148 S -> 3: :My.Little.Server PONG My.Little.Server :foo 1787482778.149 sable_ircd #x1B[2m2026-08-23T10:59:38.148801Z#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 1787482778.149 sable_ircd #x1B[2m2026-08-23T10:59:38.148864Z#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), 4)#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 synchronize544.060869076" 1787482778.149 sable_ircd #x1B[2m2026-08-23T10:59:38.148978Z#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), 4): :My.Little.Server PONG My.Little.Server :synchronize544.060869076 1787482778.149 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize544.060869076 1787482778.530 sable_history #x1B[2m2027-08-23T12:34:53.924069Z#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(1011614509372219498)), timestamp: 1819024493, clock: EventClock(1 => 1011589580643635233, 50 => 1011614257713979497, 99 => 1011589584385355781), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024493 }) }; event clock=EventClock(1 => 1011589580643635233, 50 => 1011614257713979497, 99 => 1011589584385355781) my clock=EventClock(1 => 1011589580643635233, 50 => 1011614257713979497, 99 => 1011589584385355781) 1787482778.530 sable_history #x1B[2m2027-08-23T12:34:53.925690Z#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 1787482778.750 2 -> S: MODE nick2 -w 1787482778.751 sable_ircd #x1B[2m2026-08-23T10:59:38.750549Z#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 1787482778.751 sable_ircd #x1B[2m2026-08-23T10:59:38.750620Z#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"MODE nick2 -w" 1787482778.751 sable_ircd #x1B[2m2026-08-23T10:59:38.750823Z#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 472 nick2 w :Unknown mode character 1787482778.751 sable_ircd #x1B[2m2026-08-23T10:59:38.750858Z#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 1787482778.760 sable_history #x1B[2m2027-08-23T12:32:05.075251Z#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(1011613801168183398)), timestamp: 1819024325, clock: EventClock(1 => 1011588877195939841, 50 => 1011613549509943397), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024325 }) }; event clock=EventClock(1 => 1011588877195939841, 50 => 1011613549509943397) my clock=EventClock(1 => 1011588877195939841, 50 => 1011613549509943397) 1787482778.760 sable_history #x1B[2m2027-08-23T12:32:05.076885Z#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 1787482778.850 2 -> S: PING synchronize544.762769642 1787482778.850 S -> 2: :My.Little.Server 472 nick2 w :Unknown mode character 1787482778.851 sable_ircd #x1B[2m2026-08-23T10:59:38.850793Z#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 1787482778.851 sable_ircd #x1B[2m2026-08-23T10:59:38.850870Z#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 synchronize544.762769642" 1787482779.102 sable_ircd #x1B[2m2026-08-23T10:59:39.101540Z#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 :synchronize544.762769642 1787482779.102 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize544.762769642 1787482779.102 3 -> S: MODE nick3 +w 1787482779.102 sable_ircd #x1B[2m2026-08-23T10:59:39.102191Z#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 1787482779.102 sable_ircd #x1B[2m2026-08-23T10:59:39.102246Z#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), 4)#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 nick3 +w" 1787482779.102 sable_ircd #x1B[2m2026-08-23T10:59:39.102416Z#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), 4): :My.Little.Server 472 nick3 w :Unknown mode character 1787482779.102 sable_ircd #x1B[2m2026-08-23T10:59:39.102455Z#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 1787482779.198 sable_history #x1B[2m2027-08-23T12:32:05.420043Z#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(1011613802615218278)), timestamp: 1819024325, clock: EventClock(1 => 1011588879033044993, 50 => 1011613550952783973), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024325 }) }; event clock=EventClock(1 => 1011588879033044993, 50 => 1011613550952783973) my clock=EventClock(1 => 1011588879033044993, 50 => 1011613550952783973) 1787482779.198 sable_history #x1B[2m2027-08-23T12:32:05.421788Z#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 1787482779.202 3 -> S: PING synchronize545.114715167 1787482779.202 S -> 3: :My.Little.Server 472 nick3 w :Unknown mode character 1787482779.203 sable_ircd #x1B[2m2026-08-23T10:59:39.202593Z#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 1787482779.203 sable_ircd #x1B[2m2026-08-23T10:59:39.202658Z#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), 4)#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 synchronize545.114715167" 1787482779.203 sable_ircd #x1B[2m2026-08-23T10:59:39.202798Z#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), 4): :My.Little.Server PONG My.Little.Server :synchronize545.114715167 1787482779.203 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize545.114715167 1787482779.203 1 -> S: OPER operuser operpassword 1787482779.203 sable_ircd #x1B[2m2026-08-23T10:59:39.203335Z#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 1787482779.203 sable_ircd #x1B[2m2026-08-23T10:59:39.203395Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"OPER operuser operpassword" 1787482779.242 sable_ircd #x1B[2m2026-08-23T10:59:39.242096Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2maudit#x1B[0m#x1B[2m:#x1B[0m #x1B[3mid#x1B[0m#x1B[2m=#x1B[0mAuditLogEntryId(Snowflake(879318969318641670)) #x1B[3mcategory#x1B[0m#x1B[2m=#x1B[0mGeneral #x1B[3mtimestamp#x1B[0m#x1B[2m=#x1B[0m1787482779 #x1B[3msource_id#x1B[0m#x1B[2m=#x1B[0mSome(UserId(Snowflake(879318957125799936))) #x1B[3msource_addr#x1B[0m#x1B[2m=#x1B[0mSome(127.0.0.1) #x1B[3msource_str#x1B[0m#x1B[2m=#x1B[0m"nick1!username@localhost[]{127.0.0.1}" #x1B[3maction#x1B[0m#x1B[2m=#x1B[0m"OPER" #x1B[3mtarget_id#x1B[0m#x1B[2m=#x1B[0mNone 1787482779.242 sable_ircd #x1B[2m2026-08-23T10:59:39.242180Z#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 381 nick1 :You are now an IRC operator 1787482779.242 sable_ircd #x1B[2m2026-08-23T10:59:39.242286Z#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[0mStateChange(User(UserId(Snowflake(879318957125799936))), OperUp(OperUp { oper_name: "operuser" })) 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.242425Z#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(879318969318641669)), timestamp: 1787482779, clock: EventClock(1 => 879318963887017988), target: AuditLogEntry(AuditLogEntryId(Snowflake(879318969318641670))), details: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntry { id: AuditLogEntryId(Snowflake(879318969318641670)), timestamp: 1787482779, category: General, source_id: Some(UserId(Snowflake(879318957125799936))), source_addr: Some(127.0.0.1), source_str: "nick1!username@localhost[]{127.0.0.1}", action: "OPER", target_id: None, target_str: None, target_duration: None, reason: None } }) }; event clock=EventClock(1 => 879318963887017988) my clock=EventClock(1 => 879318963887017988) 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.242524Z#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 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.242574Z#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(879318969318641670)), timestamp: 1787482779, clock: EventClock(1 => 879318969318641669), target: User(UserId(Snowflake(879318957125799936))), details: OperUp(OperUp { oper_name: "operuser" }) }; event clock=EventClock(1 => 879318969318641669) my clock=EventClock(1 => 879318969318641669) 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.242605Z#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 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.242842Z#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(879318969318641669)), timestamp: 1787482779, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(879318969318641670)) }), users_to_notify: [] }) 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.242873Z#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(879318969318641669)), timestamp: 1787482779, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(879318969318641670)) }), users_to_notify: [] } 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.242948Z#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(879318969318641669)), timestamp: 1787482779, change: EventComplete(EventComplete), users_to_notify: [] }) 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.242970Z#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(879318969318641669)), timestamp: 1787482779, change: EventComplete(EventComplete), users_to_notify: [] } 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.243011Z#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(879318969318641670)), timestamp: 1787482779, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(879318957125799936)), 2), added: UserModeSet(2), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(879318957125799936)), 2)) }), users_to_notify: [UserId(Snowflake(879318957125799936))] }) 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.243036Z#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(879318969318641670)), timestamp: 1787482779, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(879318957125799936)), 2), added: UserModeSet(2), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(879318957125799936)), 2)) }), users_to_notify: [UserId(Snowflake(879318957125799936))] } 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.243112Z#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): :nick1!username@localhost MODE nick1 +o 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.243166Z#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(879318969318641670)), timestamp: 1787482779, change: EventComplete(EventComplete), users_to_notify: [] }) 1787482779.243 sable_ircd #x1B[2m2026-08-23T10:59:39.243185Z#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(879318969318641670)), timestamp: 1787482779, change: EventComplete(EventComplete), users_to_notify: [] } 1787482779.303 1 -> S: PING synchronize545.215845564 1787482779.303 S -> 1: :My.Little.Server 381 nick1 :You are now an IRC operator 1787482779.303 S -> 1: :nick1!username@localhost MODE nick1 +o 1787482779.304 sable_ircd #x1B[2m2026-08-23T10:59:39.303619Z#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 1787482779.304 sable_ircd #x1B[2m2026-08-23T10:59:39.303678Z#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 synchronize545.215845564" 1787482779.304 sable_ircd #x1B[2m2026-08-23T10:59:39.303800Z#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 :synchronize545.215845564 1787482779.304 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize545.215845564 1787482779.304 1 -> S: WALLOPS :hi everyone 1787482779.304 sable_ircd #x1B[2m2026-08-23T10:59:39.304346Z#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 1787482779.304 sable_ircd #x1B[2m2026-08-23T10:59:39.304404Z#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"WALLOPS :hi everyone" 1787482779.305 sable_ircd #x1B[2m2026-08-23T10:59:39.304486Z#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 421 nick1 WALLOPS :Unknown command 1787482779.404 1 -> S: PING synchronize545.316876747 1787482779.404 S -> 1: :My.Little.Server 421 nick1 WALLOPS :Unknown command 1787482779.405 sable_ircd #x1B[2m2026-08-23T10:59:39.404897Z#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 1787482779.405 sable_ircd #x1B[2m2026-08-23T10:59:39.404964Z#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 synchronize545.316876747" 1787482779.544 sable_history #x1B[2m2027-08-23T12:32:05.750418Z#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(1011613803999338598)), timestamp: 1819024325, clock: EventClock(1 => 1011588880530411521, 50 => 1011613552341098597), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024325 }) }; event clock=EventClock(1 => 1011588880530411521, 50 => 1011613552341098597) my clock=EventClock(1 => 1011588880530411521, 50 => 1011613552341098597) 1787482779.544 sable_history #x1B[2m2027-08-23T12:32:05.752167Z#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 1787482779.611 sable_history #x1B[2m2027-08-23T12:37:41.898232Z#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(1011615213906239597)), timestamp: 1819024661, clock: EventClock(1 => 1011589283351367702, 50 => 1011614962247999596, 99 => 1011589287034368004), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024661 }) }; event clock=EventClock(1 => 1011589283351367702, 50 => 1011614962247999596, 99 => 1011589287034368004) my clock=EventClock(1 => 1011589283351367702, 50 => 1011614962247999596, 99 => 1011589287034368004) 1787482779.611 sable_history #x1B[2m2027-08-23T12:37:41.900107Z#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 1787482779.866 sable_history #x1B[2m2027-08-23T12:40:32.222234Z#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(1011615928296874096)), timestamp: 1819024832, clock: EventClock(1 => 1011589233531424790, 50 => 1011615676638634095, 99 => 1011589238342692868), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024832 }) }; event clock=EventClock(1 => 1011589233531424790, 50 => 1011615676638634095, 99 => 1011589238342692868) my clock=EventClock(1 => 1011589233531424790, 50 => 1011615676638634095, 99 => 1011589238342692868) 1787482779.867 sable_history #x1B[2m2027-08-23T12:40:32.224089Z#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 1787482779.965 sable_history #x1B[2m2027-08-23T12:32:06.165390Z#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(1011613805739974758)), timestamp: 1819024326, clock: EventClock(1 => 1011588882300407809, 50 => 1011613554077540453), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819024326 }) }; event clock=EventClock(1 => 1011588882300407809, 50 => 1011613554077540453) my clock=EventClock(1 => 1011588882300407809, 50 => 1011613554077540453) 1787482779.965 sable_history #x1B[2m2027-08-23T12:32:06.167256Z#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 1787482780.159 sable_ircd #x1B[2m2026-08-23T10:59:40.158943Z#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 :synchronize545.316876747 1787482780.159 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize545.316876747 1787482780.165 1: disconnects from server. 1787482780.165 2: disconnects from server. 1787482780.165 3: disconnects from server.