--------------------------------- Captured Out ---------------------------------
---- new test ----
1788128003.256 sable_ircd     uid=1001
1788128003.259 sable_ircd     #x1B[2m2026-08-30T22:13:23.259262Z#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(882025234994040832)), timestamp: 1788128003, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788128003, name: ServerName("My.Little.Server"), ts: 1788128003, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1788128003.260 sable_ircd     #x1B[2m2026-08-30T22:13:23.259371Z#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
1788128003.260 sable_ircd     #x1B[2m2026-08-30T22:13:23.259603Z#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(882025234994040832)), timestamp: 1788128003, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788128003, name: ServerName("My.Little.Server"), ts: 1788128003, 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
1788128003.260 sable_ircd     #x1B[2m2026-08-30T22:13:23.259690Z#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(882025234994040832)), timestamp: 1788128003, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1788128003.260 sable_ircd     #x1B[2m2026-08-30T22:13:23.259714Z#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(882025234994040832)), timestamp: 1788128003, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1788128003.260 sable_ircd     #x1B[2m2026-08-30T22:13:23.259736Z#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(882025234994040832)), timestamp: 1788128003, change: EventComplete(EventComplete), users_to_notify: [] })
1788128003.260 sable_ircd     #x1B[2m2026-08-30T22:13:23.259745Z#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(882025234994040832)), timestamp: 1788128003, change: EventComplete(EventComplete), users_to_notify: [] }
1788128003.261 sable_ircd     #x1B[2m2026-08-30T22:13:23.260552Z#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
1788128003.261 sable_ircd     #x1B[2m2026-08-30T22:13:23.260629Z#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(882025234998235137)), timestamp: 1788128003, clock: EventClock(1 => 882025234994040832), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788128003 }) }; event clock=EventClock(1 => 882025234994040832) my clock=EventClock(1 => 882025234994040832)
1788128003.261 sable_ircd     #x1B[2m2026-08-30T22:13:23.260685Z#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
1788128003.261 sable_ircd     #x1B[2m2026-08-30T22:13:23.260842Z#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(882025234998235137)), timestamp: 1788128003, change: EventComplete(EventComplete), users_to_notify: [] })
1788128003.261 sable_ircd     #x1B[2m2026-08-30T22:13:23.260865Z#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(882025234998235137)), timestamp: 1788128003, change: EventComplete(EventComplete), users_to_notify: [] }
1788128003.353 sable_ircd     #x1B[2m2026-08-30T22:13:23.353322Z#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 }
1788128003.353 sable_ircd     #x1B[2m2026-08-30T22:13:23.353467Z#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
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.353503Z#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
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.353567Z#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
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.353713Z#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
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.353760Z#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"
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.353861Z#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
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.353925Z#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))
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.353950Z#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)
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.354255Z#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
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.354320Z#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
1788128003.354 sable_ircd     #x1B[2m2026-08-30T22:13:23.354478Z#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
1788128003.374 1: connects to server.
1788128003.374 1 -> S: NICK nick1
1788128003.374 1 -> S: USER username * * :Realname
1788128003.374 sable_ircd     #x1B[2m2026-08-30T22:13:23.374448Z#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 }
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374535Z#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
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374560Z#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
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374602Z#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
1788128003.375 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374680Z#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
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374715Z#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"
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374827Z#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: 649, tv_nsec: 496203253 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("nick1")), realname: OnceLock(<uninit>), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374885Z#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
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374908Z#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
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374925Z#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"
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.374972Z#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: 649, tv_nsec: 496203253 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick1")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.375322Z#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
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.375349Z#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"))
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.375370Z#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
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.375405Z#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: 649, tv_nsec: 496203253 }, attach_user_id: OnceLock(<uninit>), 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(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788128003.375 sable_ircd     #x1B[2m2026-08-30T22:13:23.375440Z#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))
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.375619Z#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(882025235480580098)), timestamp: 1788128003, clock: EventClock(1 => 882025234998235137), target: User(UserId(Snowflake(882025235480580096))), 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(882025235480580097)), NewUserConnection { user: UserId(Snowflake(882025235480580096)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788128003 })) }) }; event clock=EventClock(1 => 882025234998235137) my clock=EventClock(1 => 882025234998235137)
1788128003.376 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.375701Z#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
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.375895Z#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(882025235480580098)), timestamp: 1788128003, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025235480580096)), 1) }), users_to_notify: [] })
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.375927Z#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(882025235480580098)), timestamp: 1788128003, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025235480580096)), 1) }), users_to_notify: [] }
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.375976Z#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(882025235480580098)), timestamp: 1788128003, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025235480580096)), 2), connection: UserConnectionId(Snowflake(882025235480580097)) }), users_to_notify: [] })
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.375997Z#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(882025235480580098)), timestamp: 1788128003, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025235480580096)), 2), connection: UserConnectionId(Snowflake(882025235480580097)) }), users_to_notify: [] }
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376040Z#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
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376062Z#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
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376087Z#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-30 22:13:23.376077766 UTC
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376105Z#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
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376145Z#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
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376164Z#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
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376185Z#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 +
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376203Z#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.
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376247Z#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(882025235480580098)), timestamp: 1788128003, change: EventComplete(EventComplete), users_to_notify: [] })
1788128003.376 sable_ircd     #x1B[2m2026-08-30T22:13:23.376266Z#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(882025235480580098)), timestamp: 1788128003, change: EventComplete(EventComplete), users_to_notify: [] }
1788128003.376 S -> 1: :My.Little.Server 001 nick1 :Welcome to the test Internet Relay Chat network, nick1
1788128003.377 1 -> S: PING foo
1788128003.377 sable_ircd     #x1B[2m2026-08-30T22:13:23.376665Z#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
1788128003.377 sable_ircd     #x1B[2m2026-08-30T22:13:23.376694Z#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"
1788128003.377 sable_ircd     #x1B[2m2026-08-30T22:13:23.376744Z#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
1788128003.477 1 -> S: PING synchronize649.598244159
1788128003.477 S -> 1: :My.Little.Server 002 nick1 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788128003.477 S -> 1: :My.Little.Server 003 nick1 :This server was created 2026-08-30 22:13:23.376077766 UTC
1788128003.477 S -> 1: :My.Little.Server 004 nick1 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788128003.477 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
1788128003.477 S -> 1: :My.Little.Server 422 nick1 :MOTD File is missing
1788128003.477 S -> 1: :nick1!username@localhost MODE nick1 +
1788128003.477 S -> 1: :My.Little.Server NOTICE nick1 :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788128003.477 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1788128003.477 sable_ircd     #x1B[2m2026-08-30T22:13:23.477142Z#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
1788128003.477 sable_ircd     #x1B[2m2026-08-30T22:13:23.477206Z#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 synchronize649.598244159"
1788128003.477 sable_ircd     #x1B[2m2026-08-30T22:13:23.477339Z#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 :synchronize649.598244159
1788128003.478 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize649.598244159
1788128004.179 2: connects to server.
1788128004.179 2 -> S: NICK nick2
1788128004.179 2 -> S: USER username * * :Realname
1788128004.179 sable_ircd     #x1B[2m2026-08-30T22:13:24.178953Z#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 }
1788128004.179 sable_ircd     #x1B[2m2026-08-30T22:13:24.179080Z#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
1788128004.179 sable_ircd     #x1B[2m2026-08-30T22:13:24.179116Z#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
1788128004.179 sable_ircd     #x1B[2m2026-08-30T22:13:24.179180Z#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
1788128004.179 sable_ircd     #x1B[2m2026-08-30T22:13:24.179330Z#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
1788128004.179 sable_ircd     #x1B[2m2026-08-30T22:13:24.179364Z#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"
1788128004.180 sable_ircd     #x1B[2m2026-08-30T22:13:24.179473Z#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
1788128004.180 sable_ircd     #x1B[2m2026-08-30T22:13:24.179512Z#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"
1788128004.180 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname
1788128004.180 sable_ircd     #x1B[2m2026-08-30T22:13:24.179994Z#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: 650, tv_nsec: 300772562 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(<uninit>), realname: OnceLock(Realname("Realname")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788128004.180 sable_ircd     #x1B[2m2026-08-30T22:13:24.180082Z#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: 650, tv_nsec: 300772562 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick2")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788128004.180 sable_ircd     #x1B[2m2026-08-30T22:13:24.180118Z#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
1788128004.181 sable_ircd     #x1B[2m2026-08-30T22:13:24.180665Z#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
1788128004.181 sable_ircd     #x1B[2m2026-08-30T22:13:24.180693Z#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"))
1788128004.181 sable_ircd     #x1B[2m2026-08-30T22:13:24.180717Z#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
1788128004.181 sable_ircd     #x1B[2m2026-08-30T22:13:24.180740Z#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: 650, tv_nsec: 300772562 }, attach_user_id: OnceLock(<uninit>), 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(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1788128004.181 sable_ircd     #x1B[2m2026-08-30T22:13:24.180780Z#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))
1788128004.181 sable_ircd     #x1B[2m2026-08-30T22:13:24.181144Z#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(882025238861189123)), timestamp: 1788128004, clock: EventClock(1 => 882025235480580098), target: User(UserId(Snowflake(882025238856994818))), 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(882025238856994819)), NewUserConnection { user: UserId(Snowflake(882025238856994818)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788128004 })) }) }; event clock=EventClock(1 => 882025235480580098) my clock=EventClock(1 => 882025235480580098)
1788128004.181 sable_ircd     #x1B[2m2026-08-30T22:13:24.181220Z#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
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181467Z#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(882025238861189123)), timestamp: 1788128004, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025238856994818)), 1) }), users_to_notify: [] })
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181500Z#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(882025238861189123)), timestamp: 1788128004, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882025238856994818)), 1) }), users_to_notify: [] }
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181542Z#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(882025238861189123)), timestamp: 1788128004, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025238856994818)), 2), connection: UserConnectionId(Snowflake(882025238856994819)) }), users_to_notify: [] })
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181560Z#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(882025238861189123)), timestamp: 1788128004, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882025238856994818)), 2), connection: UserConnectionId(Snowflake(882025238856994819)) }), users_to_notify: [] }
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181605Z#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
1788128004.182 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181624Z#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
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181643Z#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-30 22:13:24.181634665 UTC
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181657Z#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
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181964Z#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
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.181993Z#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
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.182009Z#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 +
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.182023Z#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.
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.182063Z#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(882025238861189123)), timestamp: 1788128004, change: EventComplete(EventComplete), users_to_notify: [] })
1788128004.182 sable_ircd     #x1B[2m2026-08-30T22:13:24.182083Z#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(882025238861189123)), timestamp: 1788128004, change: EventComplete(EventComplete), users_to_notify: [] }
1788128004.183 S -> 2: :My.Little.Server 001 nick2 :Welcome to the test Internet Relay Chat network, nick2
1788128004.183 S -> 2: :My.Little.Server 002 nick2 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788128004.183 S -> 2: :My.Little.Server 003 nick2 :This server was created 2026-08-30 22:13:24.181634665 UTC
1788128004.183 S -> 2: :My.Little.Server 004 nick2 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788128004.183 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
1788128004.183 S -> 2: :My.Little.Server 422 nick2 :MOTD File is missing
1788128004.183 S -> 2: :nick2!username@localhost MODE nick2 +
1788128004.183 S -> 2: :My.Little.Server NOTICE nick2 :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788128004.183 2 -> S: PING foo
1788128004.184 sable_ircd     #x1B[2m2026-08-30T22:13:24.183669Z#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
1788128004.184 sable_ircd     #x1B[2m2026-08-30T22:13:24.183713Z#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"
1788128004.184 sable_ircd     #x1B[2m2026-08-30T22:13:24.183786Z#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
1788128004.984 2 -> S: PING synchronize651.105171754
1788128004.984 S -> 2: :My.Little.Server PONG My.Little.Server :foo
1788128004.984 sable_ircd     #x1B[2m2026-08-30T22:13:24.984089Z#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
1788128004.984 sable_ircd     #x1B[2m2026-08-30T22:13:24.984150Z#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 synchronize651.105171754"
1788128004.984 sable_ircd     #x1B[2m2026-08-30T22:13:24.984268Z#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 :synchronize651.105171754
1788128004.985 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize651.105171754
1788128004.985 2 -> S: JOIN #chan1
1788128004.985 2 -> S: JOIN #chan2
1788128004.985 2 -> S: AWAY :I'm on a break
1788128004.985 sable_ircd     #x1B[2m2026-08-30T22:13:24.984768Z#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
1788128004.985 sable_ircd     #x1B[2m2026-08-30T22:13:24.984797Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"JOIN #chan1"
1788128004.985 sable_ircd     #x1B[2m2026-08-30T22:13:24.984834Z#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
1788128004.985 sable_ircd     #x1B[2m2026-08-30T22:13:24.984849Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"JOIN #chan2"
1788128004.985 sable_ircd     #x1B[2m2026-08-30T22:13:24.984869Z#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
1788128004.985 sable_ircd     #x1B[2m2026-08-30T22:13:24.984882Z#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"AWAY :I'm on a break"
1788128005.085 2 -> S: PING synchronize651.206328181
1788128005.085 sable_ircd     #x1B[2m2026-08-30T22:13:25.085208Z#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
1788128005.085 sable_ircd     #x1B[2m2026-08-30T22:13:25.085256Z#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 synchronize651.206328181"
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.085527Z#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(882025242652839940)), timestamp: 1788128005, clock: EventClock(1 => 882025238861189123), target: Channel(ChannelId(Snowflake(882025242652839940))), details: NewChannel(NewChannel { name: ChannelName("#chan1"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 882025238861189123) my clock=EventClock(1 => 882025238861189123)
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.085678Z#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
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.085738Z#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(882025242652839941)), timestamp: 1788128005, clock: EventClock(1 => 882025242652839940), target: Membership(MembershipId(UserId(Snowflake(882025238856994818)), ChannelId(Snowflake(882025242652839940)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882025242652839940)), user: UserId(Snowflake(882025238856994818)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 882025242652839940) my clock=EventClock(1 => 882025242652839940)
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.085815Z#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
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.085874Z#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
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086013Z#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(882025242652839940)), timestamp: 1788128005, change: EventComplete(EventComplete), users_to_notify: [] })
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086039Z#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(882025242652839940)), timestamp: 1788128005, change: EventComplete(EventComplete), users_to_notify: [] }
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086070Z#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(882025242652839941)), timestamp: 1788128005, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025238856994818)), ChannelId(Snowflake(882025242652839940))), user: HistoricUserId(UserId(Snowflake(882025238856994818)), 2) }), users_to_notify: [UserId(Snowflake(882025238856994818))] })
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086084Z#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(882025242652839941)), timestamp: 1788128005, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025238856994818)), ChannelId(Snowflake(882025242652839940))), user: HistoricUserId(UserId(Snowflake(882025238856994818)), 2) }), users_to_notify: [UserId(Snowflake(882025238856994818))] }
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086129Z#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 JOIN #chan1
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086153Z#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 #chan1 +o nick2
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086180Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 353 nick2 = #chan1 :@nick2
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086191Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 366 nick2 #chan1 :End of names list
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086216Z#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(882025242652839941)), timestamp: 1788128005, change: EventComplete(EventComplete), users_to_notify: [] })
1788128005.086 sable_ircd     #x1B[2m2026-08-30T22:13:25.086228Z#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(882025242652839941)), timestamp: 1788128005, change: EventComplete(EventComplete), users_to_notify: [] }
1788128005.086 S -> 2: :nick2!username@localhost JOIN #chan1
1788128005.127 S -> 2: :nick2!username@localhost MODE #chan1 +o nick2
1788128005.128 S -> 2: :My.Little.Server 353 nick2 = #chan1 :@nick2
1788128005.128 S -> 2: :My.Little.Server 366 nick2 #chan1 :End of names list
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.090724Z#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(882025246868115462)), timestamp: 1788128006, clock: EventClock(1 => 882025242652839941), target: Channel(ChannelId(Snowflake(882025246868115461))), details: NewChannel(NewChannel { name: ChannelName("#chan2"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 882025242652839941) my clock=EventClock(1 => 882025242652839941)
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.090902Z#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
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.090969Z#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(882025246868115463)), timestamp: 1788128006, clock: EventClock(1 => 882025246868115462), target: Membership(MembershipId(UserId(Snowflake(882025238856994818)), ChannelId(Snowflake(882025246868115461)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882025246868115461)), user: UserId(Snowflake(882025238856994818)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 882025246868115462) my clock=EventClock(1 => 882025246868115462)
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091046Z#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
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091113Z#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
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091137Z#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(882025246868115462)), timestamp: 1788128006, change: EventComplete(EventComplete), users_to_notify: [] })
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091168Z#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(882025246868115462)), timestamp: 1788128006, change: EventComplete(EventComplete), users_to_notify: [] }
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091289Z#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(882025246868115463)), timestamp: 1788128006, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025238856994818)), ChannelId(Snowflake(882025246868115461))), user: HistoricUserId(UserId(Snowflake(882025238856994818)), 2) }), users_to_notify: [UserId(Snowflake(882025238856994818))] })
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091319Z#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(882025246868115463)), timestamp: 1788128006, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882025238856994818)), ChannelId(Snowflake(882025246868115461))), user: HistoricUserId(UserId(Snowflake(882025238856994818)), 2) }), users_to_notify: [UserId(Snowflake(882025238856994818))] }
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091372Z#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 JOIN #chan2
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091418Z#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 #chan2 +o nick2
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091446Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 353 nick2 = #chan2 :@nick2
1788128006.091 sable_ircd     #x1B[2m2026-08-30T22:13:26.091458Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 366 nick2 #chan2 :End of names list
1788128006.092 sable_ircd     #x1B[2m2026-08-30T22:13:26.091492Z#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(882025246868115463)), timestamp: 1788128006, change: EventComplete(EventComplete), users_to_notify: [] })
1788128006.092 sable_ircd     #x1B[2m2026-08-30T22:13:26.091504Z#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(882025246868115463)), timestamp: 1788128006, change: EventComplete(EventComplete), users_to_notify: [] }
1788128006.092 S -> 2: :nick2!username@localhost JOIN #chan2
1788128006.092 S -> 2: :nick2!username@localhost MODE #chan2 +o nick2
1788128006.092 S -> 2: :My.Little.Server 353 nick2 = #chan2 :@nick2
1788128006.092 S -> 2: :My.Little.Server 366 nick2 #chan2 :End of names list
1788128007.093 2: waiting…
1788128007.097 sable_ircd     #x1B[2m2026-08-30T22:13:27.097039Z#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(882025251091779592)), timestamp: 1788128007, clock: EventClock(1 => 882025246868115463), target: User(UserId(Snowflake(882025238856994818))), details: UserAway(UserAway { reason: Some(AwayReason("I'm on a break")) }) }; event clock=EventClock(1 => 882025246868115463) my clock=EventClock(1 => 882025246868115463)
1788128007.097 sable_ircd     #x1B[2m2026-08-30T22:13:27.097173Z#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
1788128007.097 sable_ircd     #x1B[2m2026-08-30T22:13:27.097181Z#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
1788128007.097 sable_ircd     #x1B[2m2026-08-30T22:13:27.097362Z#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(882025251091779592)), timestamp: 1788128007, change: UserAwayChange(UserAwayChange { user: HistoricUserId(UserId(Snowflake(882025238856994818)), 3), old_reason: None, new_reason: Some(AwayReason("I'm on a break")) }), users_to_notify: [UserId(Snowflake(882025238856994818))] })
1788128007.097 sable_ircd     #x1B[2m2026-08-30T22:13:27.097405Z#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(882025251091779592)), timestamp: 1788128007, change: UserAwayChange(UserAwayChange { user: HistoricUserId(UserId(Snowflake(882025238856994818)), 3), old_reason: None, new_reason: Some(AwayReason("I'm on a break")) }), users_to_notify: [UserId(Snowflake(882025238856994818))] }
1788128007.097 sable_ircd     #x1B[2m2026-08-30T22:13:27.097434Z#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 306 nick2 :You have been marked as being away
1788128007.097 sable_ircd     #x1B[2m2026-08-30T22:13:27.097465Z#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(882025251091779592)), timestamp: 1788128007, change: EventComplete(EventComplete), users_to_notify: [] })
1788128007.097 sable_ircd     #x1B[2m2026-08-30T22:13:27.097476Z#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(882025251091779592)), timestamp: 1788128007, change: EventComplete(EventComplete), users_to_notify: [] }
1788128007.098 S -> 2: :My.Little.Server 306 nick2 :You have been marked as being away
1788128008.099 2: waiting…
1788128008.104 sable_ircd     #x1B[2m2026-08-30T22:13:28.103941Z#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 :synchronize651.206328181
1788128008.104 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize651.206328181
1788128008.205 1 -> S: PING synchronize654.326176553
1788128008.205 sable_ircd     #x1B[2m2026-08-30T22:13:28.204951Z#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
1788128008.205 sable_ircd     #x1B[2m2026-08-30T22:13:28.205006Z#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 synchronize654.326176553"
1788128008.205 sable_ircd     #x1B[2m2026-08-30T22:13:28.205115Z#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 :synchronize654.326176553
1788128008.205 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize654.326176553
1788128008.205 1 -> S: WHOIS nick2
1788128008.206 sable_ircd     #x1B[2m2026-08-30T22:13:28.205542Z#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
1788128008.206 sable_ircd     #x1B[2m2026-08-30T22:13:28.205577Z#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"WHOIS nick2"
1788128008.206 sable_ircd     #x1B[2m2026-08-30T22:13:28.205660Z#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 311 nick1 nick2 username localhost * :Realname
1788128008.206 sable_ircd     #x1B[2m2026-08-30T22:13:28.205688Z#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 301 nick1 nick2 :I'm on a break
1788128008.206 sable_ircd     #x1B[2m2026-08-30T22:13:28.205709Z#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 318 nick1 nick2 :End of /WHOIS
1788128008.306 1 -> S: PING synchronize654.427133849
1788128008.306 S -> 1: :My.Little.Server 311 nick1 nick2 username localhost * :Realname
1788128008.306 S -> 1: :My.Little.Server 301 nick1 nick2 :I'm on a break
1788128008.306 S -> 1: :My.Little.Server 318 nick1 nick2 :End of /WHOIS
1788128008.306 sable_ircd     #x1B[2m2026-08-30T22:13:28.305960Z#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
1788128008.306 sable_ircd     #x1B[2m2026-08-30T22:13:28.306019Z#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 synchronize654.427133849"
1788128008.306 sable_ircd     #x1B[2m2026-08-30T22:13:28.306133Z#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 :synchronize654.427133849
1788128008.306 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize654.427133849
1788128008.309 1: disconnects from server.
1788128008.309 2: disconnects from server.