--------------------------------- Captured Out --------------------------------- ---- new test ---- 1771059265.019 sable_ircd uid=1001 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.022493Z#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(810433757931638784)), timestamp: 1771059265, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1771059265, name: ServerName("My.Little.Server"), ts: 1771059265, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.022606Z#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 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.022848Z#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(810433757931638784)), timestamp: 1771059265, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1771059265, name: ServerName("My.Little.Server"), ts: 1771059265, 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 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.023010Z#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(810433757931638784)), timestamp: 1771059265, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.023050Z#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(810433757931638784)), timestamp: 1771059265, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.023069Z#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(810433757935833089)), timestamp: 1771059265, clock: EventClock(1 => 810433757931638784), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1771059265 }) }; event clock=EventClock(1 => 810433757931638784) my clock=EventClock(1 => 810433757931638784) 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.023122Z#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 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.023135Z#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 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.023198Z#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(810433757931638784)), timestamp: 1771059265, change: EventComplete(EventComplete), users_to_notify: [] }) 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.023233Z#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(810433757931638784)), timestamp: 1771059265, change: EventComplete(EventComplete), users_to_notify: [] } 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.023370Z#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(810433757935833089)), timestamp: 1771059265, change: EventComplete(EventComplete), users_to_notify: [] }) 1771059265.023 sable_ircd #x1B[2m2026-02-14T08:54:25.023406Z#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(810433757935833089)), timestamp: 1771059265, change: EventComplete(EventComplete), users_to_notify: [] } 1771059265.115 sable_ircd #x1B[2m2026-02-14T08:54:25.114673Z#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 } 1771059265.115 sable_ircd #x1B[2m2026-02-14T08:54:25.114824Z#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 1771059265.115 sable_ircd #x1B[2m2026-02-14T08:54:25.114874Z#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 1771059265.115 sable_ircd #x1B[2m2026-02-14T08:54:25.114924Z#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 1771059265.115 sable_ircd #x1B[2m2026-02-14T08:54:25.115049Z#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 1771059265.115 sable_ircd #x1B[2m2026-02-14T08:54:25.115131Z#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" 1771059265.115 sable_ircd #x1B[2m2026-02-14T08:54:25.115265Z#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 1771059265.115 sable_ircd #x1B[2m2026-02-14T08:54:25.115408Z#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)) 1771059265.116 sable_ircd #x1B[2m2026-02-14T08:54:25.115460Z#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) 1771059265.116 sable_ircd #x1B[2m2026-02-14T08:54:25.115981Z#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 1771059265.116 sable_ircd #x1B[2m2026-02-14T08:54:25.116025Z#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 1771059265.116 sable_ircd #x1B[2m2026-02-14T08:54:25.116103Z#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 1771059265.136 chanop: connects to server. 1771059265.136 chanop -> S: NICK chanop 1771059265.136 chanop -> S: USER username * * :Realname 1771059265.136 sable_ircd #x1B[2m2026-02-14T08:54:25.135912Z#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 } 1771059265.136 sable_ircd #x1B[2m2026-02-14T08:54:25.136065Z#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 1771059265.136 sable_ircd #x1B[2m2026-02-14T08:54:25.136112Z#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 1771059265.136 sable_ircd #x1B[2m2026-02-14T08:54:25.136162Z#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 1771059265.136 sable_ircd #x1B[2m2026-02-14T08:54:25.136309Z#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 1771059265.136 sable_ircd #x1B[2m2026-02-14T08:54:25.136384Z#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 chanop" 1771059265.136 S -> chanop: :My.Little.Server NOTICE * :*** Looking up your hostname 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.136541Z#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: 293, tv_nsec: 202396854 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("chanop")), 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 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.136622Z#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 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.136689Z#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 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.136738Z#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" 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.136854Z#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: 293, tv_nsec: 202396854 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("chanop")), 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 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.137280Z#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 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.137322Z#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")) 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.137355Z#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 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.137378Z#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: 293, tv_nsec: 202396854 }, attach_user_id: OnceLock(), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("chanop")), 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 1771059265.137 sable_ircd #x1B[2m2026-02-14T08:54:25.137428Z#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)) 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.137636Z#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(810433758413983746)), timestamp: 1771059265, clock: EventClock(1 => 810433757935833089), target: User(UserId(Snowflake(810433758413983744))), details: NewUser(NewUser { nickname: Nickname("chanop"), 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(810433758413983745)), NewUserConnection { user: UserId(Snowflake(810433758413983744)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059265 })) }) }; event clock=EventClock(1 => 810433757935833089) my clock=EventClock(1 => 810433757935833089) 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.137720Z#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 1771059265.138 S -> chanop: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138042Z#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(810433758413983746)), timestamp: 1771059265, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(810433758413983744)), 1) }), users_to_notify: [] }) 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138074Z#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(810433758413983746)), timestamp: 1771059265, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(810433758413983744)), 1) }), users_to_notify: [] } 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138110Z#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(810433758413983746)), timestamp: 1771059265, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(810433758413983744)), 2), connection: UserConnectionId(Snowflake(810433758413983745)) }), users_to_notify: [] }) 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138131Z#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(810433758413983746)), timestamp: 1771059265, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(810433758413983744)), 2), connection: UserConnectionId(Snowflake(810433758413983745)) }), users_to_notify: [] } 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138173Z#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 chanop :Welcome to the test Internet Relay Chat network, chanop 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138199Z#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 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138220Z#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 chanop :This server was created 2026-02-14 08:54:25.138213323 UTC 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138238Z#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 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138269Z#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 chanop 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 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138289Z#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 chanop :MOTD File is missing 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138312Z#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): :chanop!username@localhost MODE chanop + 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138329Z#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 chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138370Z#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(810433758413983746)), timestamp: 1771059265, change: EventComplete(EventComplete), users_to_notify: [] }) 1771059265.138 sable_ircd #x1B[2m2026-02-14T08:54:25.138391Z#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(810433758413983746)), timestamp: 1771059265, change: EventComplete(EventComplete), users_to_notify: [] } 1771059265.139 S -> chanop: :My.Little.Server 001 chanop :Welcome to the test Internet Relay Chat network, chanop 1771059265.139 chanop -> S: PING foo 1771059265.139 sable_ircd #x1B[2m2026-02-14T08:54:25.138957Z#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 1771059265.139 sable_ircd #x1B[2m2026-02-14T08:54:25.139012Z#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" 1771059265.139 sable_ircd #x1B[2m2026-02-14T08:54:25.139109Z#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 1771059265.239 chanop -> S: PING synchronize293.305054911 1771059265.239 S -> chanop: :My.Little.Server 002 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1771059265.239 S -> chanop: :My.Little.Server 003 chanop :This server was created 2026-02-14 08:54:25.138213323 UTC 1771059265.239 S -> chanop: :My.Little.Server 004 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1771059265.239 S -> chanop: :My.Little.Server 005 chanop 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 1771059265.239 S -> chanop: :My.Little.Server 422 chanop :MOTD File is missing 1771059265.239 S -> chanop: :chanop!username@localhost MODE chanop + 1771059265.239 S -> chanop: :My.Little.Server NOTICE chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1771059265.239 S -> chanop: :My.Little.Server PONG My.Little.Server :foo 1771059265.239 sable_ircd #x1B[2m2026-02-14T08:54:25.239213Z#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 1771059265.239 sable_ircd #x1B[2m2026-02-14T08:54:25.239285Z#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 synchronize293.305054911" 1771059265.239 sable_ircd #x1B[2m2026-02-14T08:54:25.239411Z#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 :synchronize293.305054911 1771059265.240 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize293.305054911 1771059265.941 chanop -> S: JOIN #chan 1771059265.941 sable_ircd #x1B[2m2026-02-14T08:54:25.941176Z#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 1771059265.941 sable_ircd #x1B[2m2026-02-14T08:54:25.941266Z#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 #chan" 1771059266.041 chanop -> S: PING synchronize294.107020932 1771059266.041 sable_ircd #x1B[2m2026-02-14T08:54:26.041157Z#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 1771059266.041 sable_ircd #x1B[2m2026-02-14T08:54:26.041221Z#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 synchronize294.107020932" 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.041469Z#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(810433762205634563)), timestamp: 1771059266, clock: EventClock(1 => 810433758413983746), target: Channel(ChannelId(Snowflake(810433762205634562))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 810433758413983746) my clock=EventClock(1 => 810433758413983746) 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.041624Z#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 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.041721Z#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(810433762205634564)), timestamp: 1771059266, clock: EventClock(1 => 810433762205634563), target: Membership(MembershipId(UserId(Snowflake(810433758413983744)), ChannelId(Snowflake(810433762205634562)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(810433762205634562)), user: UserId(Snowflake(810433758413983744)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 810433762205634563) my clock=EventClock(1 => 810433762205634563) 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.041887Z#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 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.041939Z#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 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.041981Z#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(810433762205634563)), timestamp: 1771059266, change: EventComplete(EventComplete), users_to_notify: [] }) 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.042032Z#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(810433762205634563)), timestamp: 1771059266, change: EventComplete(EventComplete), users_to_notify: [] } 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.042239Z#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(810433762205634564)), timestamp: 1771059266, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(810433758413983744)), ChannelId(Snowflake(810433762205634562))), user: HistoricUserId(UserId(Snowflake(810433758413983744)), 2) }), users_to_notify: [UserId(Snowflake(810433758413983744))] }) 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.042273Z#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(810433762205634564)), timestamp: 1771059266, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(810433758413983744)), ChannelId(Snowflake(810433762205634562))), user: HistoricUserId(UserId(Snowflake(810433758413983744)), 2) }), users_to_notify: [UserId(Snowflake(810433758413983744))] } 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.042319Z#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): :chanop!username@localhost JOIN #chan 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.042354Z#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): :chanop!username@localhost MODE #chan +o chanop 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.042391Z#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 chanop = #chan :@chanop 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.042412Z#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 chanop #chan :End of names list 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.042461Z#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(810433762205634564)), timestamp: 1771059266, change: EventComplete(EventComplete), users_to_notify: [] }) 1771059266.042 sable_ircd #x1B[2m2026-02-14T08:54:26.042484Z#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(810433762205634564)), timestamp: 1771059266, change: EventComplete(EventComplete), users_to_notify: [] } 1771059266.043 S -> chanop: :chanop!username@localhost JOIN #chan 1771059266.043 S -> chanop: :chanop!username@localhost MODE #chan +o chanop 1771059266.043 S -> chanop: :My.Little.Server 353 chanop = #chan :@chanop 1771059266.043 S -> chanop: :My.Little.Server 366 chanop #chan :End of names list 1771059267.044 chanop: waiting… 1771059267.048 sable_ircd #x1B[2m2026-02-14T08:54:27.047907Z#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 :synchronize294.107020932 1771059267.048 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize294.107020932 1771059267.048 chanop -> S: MODE #chan +int 1771059267.049 sable_ircd #x1B[2m2026-02-14T08:54:27.048624Z#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 1771059267.049 sable_ircd #x1B[2m2026-02-14T08:54:27.048678Z#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 #chan +int" 1771059267.148 chanop -> S: PING synchronize295.214709109 1771059267.149 sable_ircd #x1B[2m2026-02-14T08:54:27.148897Z#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 1771059267.149 sable_ircd #x1B[2m2026-02-14T08:54:27.148964Z#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 synchronize295.214709109" 1771059268.150 chanop: waiting… 1771059268.155 sable_ircd #x1B[2m2026-02-14T08:54:28.154559Z#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(810433771068198917)), timestamp: 1771059268, clock: EventClock(1 => 810433762205634564), target: Channel(ChannelId(Snowflake(810433762205634562))), details: ChannelModeChange(ChannelModeChange { changed_by: User(UserId(Snowflake(810433758413983744))), added: ChannelModeSet(11), removed: ChannelModeSet(0), key_change: NoChange }) }; event clock=EventClock(1 => 810433762205634564) my clock=EventClock(1 => 810433762205634564) 1771059268.155 sable_ircd #x1B[2m2026-02-14T08:54:28.154733Z#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 1771059268.155 sable_ircd #x1B[2m2026-02-14T08:54:28.154736Z#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 1771059268.155 sable_ircd #x1B[2m2026-02-14T08:54:28.155031Z#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(810433771068198917)), timestamp: 1771059268, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(810433762205634562)), added: ChannelModeSet(11), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(810433758413983744)), 2)) }), users_to_notify: [UserId(Snowflake(810433758413983744))] }) 1771059268.155 sable_ircd #x1B[2m2026-02-14T08:54:28.155080Z#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(810433771068198917)), timestamp: 1771059268, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(810433762205634562)), added: ChannelModeSet(11), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(810433758413983744)), 2)) }), users_to_notify: [UserId(Snowflake(810433758413983744))] } 1771059268.155 sable_ircd #x1B[2m2026-02-14T08:54:28.155165Z#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): :chanop!username@localhost MODE #chan +nti 1771059268.155 sable_ircd #x1B[2m2026-02-14T08:54:28.155248Z#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(810433771068198917)), timestamp: 1771059268, change: EventComplete(EventComplete), users_to_notify: [] }) 1771059268.155 sable_ircd #x1B[2m2026-02-14T08:54:28.155283Z#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(810433771068198917)), timestamp: 1771059268, change: EventComplete(EventComplete), users_to_notify: [] } 1771059268.156 S -> chanop: :chanop!username@localhost MODE #chan +nti 1771059269.157 chanop: waiting… 1771059269.160 sable_ircd #x1B[2m2026-02-14T08:54:29.159691Z#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 :synchronize295.214709109 1771059269.160 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize295.214709109 1771059269.160 chanop -> S: MODE #chan 1771059269.160 sable_ircd #x1B[2m2026-02-14T08:54:29.160430Z#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 1771059269.160 sable_ircd #x1B[2m2026-02-14T08:54:29.160472Z#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 #chan" 1771059269.260 chanop -> S: PING synchronize297.326537493 1771059269.261 sable_ircd #x1B[2m2026-02-14T08:54:29.260713Z#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 1771059269.261 sable_ircd #x1B[2m2026-02-14T08:54:29.260801Z#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 synchronize297.326537493" 1771059270.015 sable_ircd #x1B[2m2026-02-14T08:54:30.014664Z#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 324 chanop #chan +nti 1771059270.015 sable_ircd #x1B[2m2026-02-14T08:54:30.014719Z#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 1771059270.015 S -> chanop: :My.Little.Server 324 chanop #chan +nti 1771059271.016 chanop: waiting… 1771059271.019 sable_ircd #x1B[2m2026-02-14T08:54:31.018960Z#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 :synchronize297.326537493 1771059271.019 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize297.326537493 1771059271.019 chanop -> S: MODE #chan -nti 1771059271.020 sable_ircd #x1B[2m2026-02-14T08:54:31.020223Z#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 1771059271.020 sable_ircd #x1B[2m2026-02-14T08:54:31.020277Z#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 #chan -nti" 1771059271.120 chanop -> S: PING synchronize299.185809365 1771059271.120 sable_ircd #x1B[2m2026-02-14T08:54:31.120059Z#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 1771059271.120 sable_ircd #x1B[2m2026-02-14T08:54:31.120117Z#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 synchronize299.185809365" 1771059272.120 chanop: waiting… 1771059272.126 sable_ircd #x1B[2m2026-02-14T08:54:32.125633Z#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(810433787723780102)), timestamp: 1771059272, clock: EventClock(1 => 810433771068198917), target: Channel(ChannelId(Snowflake(810433762205634562))), details: ChannelModeChange(ChannelModeChange { changed_by: User(UserId(Snowflake(810433758413983744))), added: ChannelModeSet(0), removed: ChannelModeSet(11), key_change: NoChange }) }; event clock=EventClock(1 => 810433771068198917) my clock=EventClock(1 => 810433771068198917) 1771059272.126 sable_ircd #x1B[2m2026-02-14T08:54:32.125819Z#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 1771059272.126 sable_ircd #x1B[2m2026-02-14T08:54:32.125823Z#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 1771059272.126 sable_ircd #x1B[2m2026-02-14T08:54:32.126092Z#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(810433787723780102)), timestamp: 1771059272, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(810433762205634562)), added: ChannelModeSet(0), removed: ChannelModeSet(11), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(810433758413983744)), 2)) }), users_to_notify: [UserId(Snowflake(810433758413983744))] }) 1771059272.126 sable_ircd #x1B[2m2026-02-14T08:54:32.126142Z#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(810433787723780102)), timestamp: 1771059272, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(810433762205634562)), added: ChannelModeSet(0), removed: ChannelModeSet(11), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(810433758413983744)), 2)) }), users_to_notify: [UserId(Snowflake(810433758413983744))] } 1771059272.126 sable_ircd #x1B[2m2026-02-14T08:54:32.126229Z#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): :chanop!username@localhost MODE #chan -nti 1771059272.126 sable_ircd #x1B[2m2026-02-14T08:54:32.126294Z#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(810433787723780102)), timestamp: 1771059272, change: EventComplete(EventComplete), users_to_notify: [] }) 1771059272.126 sable_ircd #x1B[2m2026-02-14T08:54:32.126329Z#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(810433787723780102)), timestamp: 1771059272, change: EventComplete(EventComplete), users_to_notify: [] } 1771059272.127 S -> chanop: :chanop!username@localhost MODE #chan -nti 1771059273.127 chanop: waiting… 1771059273.131 sable_ircd #x1B[2m2026-02-14T08:54:33.130538Z#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 :synchronize299.185809365 1771059273.131 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize299.185809365 1771059273.131 chanop -> S: MODE #chan 1771059273.132 sable_ircd #x1B[2m2026-02-14T08:54:33.131490Z#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 1771059273.132 sable_ircd #x1B[2m2026-02-14T08:54:33.131537Z#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 #chan" 1771059273.231 chanop -> S: PING synchronize301.29753213 1771059273.232 sable_ircd #x1B[2m2026-02-14T08:54:33.231669Z#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 1771059273.232 sable_ircd #x1B[2m2026-02-14T08:54:33.231719Z#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 synchronize301.29753213" 1771059274.232 chanop: waiting… 1771059274.236 sable_ircd #x1B[2m2026-02-14T08:54:34.236008Z#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 324 chanop #chan + 1771059274.236 sable_ircd #x1B[2m2026-02-14T08:54:34.236075Z#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 1771059274.236 S -> chanop: :My.Little.Server 324 chanop #chan + 1771059275.237 chanop: waiting… 1771059275.242 sable_ircd #x1B[2m2026-02-14T08:54:35.242409Z#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 :synchronize301.29753213 1771059275.243 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize301.29753213 1771059275.247 chanop: disconnects from server.