--------------------------------- Captured Out ---------------------------------
---- new test ----
1782833767.232 sable_ircd     uid=1001
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.235132Z#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(859819599661633536)), timestamp: 1782833767, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833767, name: ServerName("My.Little.Server"), ts: 1782833767, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.235258Z#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
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.235278Z#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
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.235401Z#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(859819599661633537)), timestamp: 1782833767, clock: EventClock(1 => 859819599661633536), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1782833767 }) }; event clock=EventClock(1 => 859819599661633536) my clock=EventClock(1 => 859819599661633536)
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.235462Z#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
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.235696Z#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(859819599661633536)), timestamp: 1782833767, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1782833767, name: ServerName("My.Little.Server"), ts: 1782833767, 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
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.235910Z#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(859819599661633536)), timestamp: 1782833767, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.235951Z#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(859819599661633536)), timestamp: 1782833767, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.236007Z#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(859819599661633536)), timestamp: 1782833767, change: EventComplete(EventComplete), users_to_notify: [] })
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.236038Z#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(859819599661633536)), timestamp: 1782833767, change: EventComplete(EventComplete), users_to_notify: [] }
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.236084Z#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(859819599661633537)), timestamp: 1782833767, change: EventComplete(EventComplete), users_to_notify: [] })
1782833767.236 sable_ircd     #x1B[2m2026-06-30T15:36:07.236112Z#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(859819599661633537)), timestamp: 1782833767, change: EventComplete(EventComplete), users_to_notify: [] }
1782833767.328 sable_ircd     #x1B[2m2026-06-30T15:36:07.327557Z#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 }
1782833767.328 sable_ircd     #x1B[2m2026-06-30T15:36:07.327732Z#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
1782833767.328 sable_ircd     #x1B[2m2026-06-30T15:36:07.327807Z#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
1782833767.328 sable_ircd     #x1B[2m2026-06-30T15:36:07.327911Z#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
1782833767.328 sable_ircd     #x1B[2m2026-06-30T15:36:07.328143Z#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
1782833767.328 sable_ircd     #x1B[2m2026-06-30T15:36:07.328213Z#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"
1782833767.328 sable_ircd     #x1B[2m2026-06-30T15:36:07.328388Z#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
1782833767.329 sable_ircd     #x1B[2m2026-06-30T15:36:07.328525Z#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))
1782833767.329 sable_ircd     #x1B[2m2026-06-30T15:36:07.328575Z#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)
1782833767.329 sable_ircd     #x1B[2m2026-06-30T15:36:07.329183Z#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
1782833767.329 sable_ircd     #x1B[2m2026-06-30T15:36:07.329277Z#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
1782833767.329 sable_ircd     #x1B[2m2026-06-30T15:36:07.329443Z#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
1782833767.349 ircop: connects to server.
1782833767.349 ircop -> S: NICK ircop
1782833767.349 ircop -> S: USER username * * :Realname
1782833767.349 sable_ircd     #x1B[2m2026-06-30T15:36:07.349077Z#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 }
1782833767.349 sable_ircd     #x1B[2m2026-06-30T15:36:07.349173Z#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
1782833767.349 sable_ircd     #x1B[2m2026-06-30T15:36:07.349208Z#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
1782833767.349 sable_ircd     #x1B[2m2026-06-30T15:36:07.349263Z#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
1782833767.349 sable_ircd     #x1B[2m2026-06-30T15:36:07.349420Z#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
1782833767.350 sable_ircd     #x1B[2m2026-06-30T15:36:07.349480Z#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 ircop"
1782833767.350 S -> ircop: :My.Little.Server NOTICE * :*** Looking up your hostname
1782833767.350 sable_ircd     #x1B[2m2026-06-30T15:36:07.349606Z#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
1782833767.350 sable_ircd     #x1B[2m2026-06-30T15:36:07.349666Z#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"
1782833767.350 sable_ircd     #x1B[2m2026-06-30T15:36:07.349772Z#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: 551, tv_nsec: 572892341 }, 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
1782833767.350 sable_ircd     #x1B[2m2026-06-30T15:36:07.349873Z#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: 551, tv_nsec: 572892341 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("ircop")), 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
1782833767.350 sable_ircd     #x1B[2m2026-06-30T15:36:07.349947Z#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
1782833767.350 sable_ircd     #x1B[2m2026-06-30T15:36:07.350408Z#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
1782833767.350 sable_ircd     #x1B[2m2026-06-30T15:36:07.350468Z#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"))
1782833767.351 sable_ircd     #x1B[2m2026-06-30T15:36:07.350499Z#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
1782833767.351 sable_ircd     #x1B[2m2026-06-30T15:36:07.350522Z#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: 551, tv_nsec: 572892341 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("ircop")), 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
1782833767.351 sable_ircd     #x1B[2m2026-06-30T15:36:07.350568Z#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))
1782833767.351 sable_ircd     #x1B[2m2026-06-30T15:36:07.350838Z#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(859819600143978498)), timestamp: 1782833767, clock: EventClock(1 => 859819599661633537), target: User(UserId(Snowflake(859819600143978496))), details: NewUser(NewUser { nickname: Nickname("ircop"), 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(859819600143978497)), NewUserConnection { user: UserId(Snowflake(859819600143978496)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833767 })) }) }; event clock=EventClock(1 => 859819599661633537) my clock=EventClock(1 => 859819599661633537)
1782833767.351 S -> ircop: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1782833767.351 sable_ircd     #x1B[2m2026-06-30T15:36:07.350958Z#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
1782833767.351 sable_ircd     #x1B[2m2026-06-30T15:36:07.351230Z#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(859819600143978498)), timestamp: 1782833767, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819600143978496)), 1) }), users_to_notify: [] })
1782833767.351 sable_ircd     #x1B[2m2026-06-30T15:36:07.351273Z#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(859819600143978498)), timestamp: 1782833767, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819600143978496)), 1) }), users_to_notify: [] }
1782833767.351 sable_ircd     #x1B[2m2026-06-30T15:36:07.351343Z#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(859819600143978498)), timestamp: 1782833767, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819600143978496)), 2), connection: UserConnectionId(Snowflake(859819600143978497)) }), users_to_notify: [] })
1782833767.351 sable_ircd     #x1B[2m2026-06-30T15:36:07.351408Z#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(859819600143978498)), timestamp: 1782833767, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819600143978496)), 2), connection: UserConnectionId(Snowflake(859819600143978497)) }), users_to_notify: [] }
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351484Z#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 ircop :Welcome to the test Internet Relay Chat network, ircop
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351532Z#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 ircop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351589Z#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 ircop :This server was created 2026-06-30 15:36:07.351569457 UTC
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351629Z#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 ircop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351691Z#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 ircop 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
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351726Z#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 ircop :MOTD File is missing
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351777Z#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): :ircop!username@localhost MODE ircop +
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351810Z#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 ircop :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351882Z#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(859819600143978498)), timestamp: 1782833767, change: EventComplete(EventComplete), users_to_notify: [] })
1782833767.352 sable_ircd     #x1B[2m2026-06-30T15:36:07.351916Z#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(859819600143978498)), timestamp: 1782833767, change: EventComplete(EventComplete), users_to_notify: [] }
1782833767.352 S -> ircop: :My.Little.Server 001 ircop :Welcome to the test Internet Relay Chat network, ircop
1782833767.352 ircop -> S: PING foo
1782833767.353 sable_ircd     #x1B[2m2026-06-30T15:36:07.352481Z#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
1782833767.353 sable_ircd     #x1B[2m2026-06-30T15:36:07.352522Z#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"
1782833767.353 sable_ircd     #x1B[2m2026-06-30T15:36:07.352597Z#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
1782833767.452 ircop -> S: PING synchronize551.676023672
1782833767.453 S -> ircop: :My.Little.Server 002 ircop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1782833767.453 S -> ircop: :My.Little.Server 003 ircop :This server was created 2026-06-30 15:36:07.351569457 UTC
1782833767.453 S -> ircop: :My.Little.Server 004 ircop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1782833767.453 S -> ircop: :My.Little.Server 005 ircop 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
1782833767.453 S -> ircop: :My.Little.Server 422 ircop :MOTD File is missing
1782833767.453 S -> ircop: :ircop!username@localhost MODE ircop +
1782833767.453 S -> ircop: :My.Little.Server NOTICE ircop :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1782833767.453 S -> ircop: :My.Little.Server PONG My.Little.Server :foo
1782833767.453 sable_ircd     #x1B[2m2026-06-30T15:36:07.452952Z#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
1782833767.453 sable_ircd     #x1B[2m2026-06-30T15:36:07.453034Z#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 synchronize551.676023672"
1782833767.453 sable_ircd     #x1B[2m2026-06-30T15:36:07.453196Z#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 :synchronize551.676023672
1782833767.454 S -> ircop: :My.Little.Server PONG My.Little.Server :synchronize551.676023672
1782833768.155 alice: connects to server.
1782833768.155 alice -> S: NICK alice
1782833768.155 alice -> S: USER username * * :Realname
1782833768.155 sable_ircd     #x1B[2m2026-06-30T15:36:08.155232Z#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 }
1782833768.155 sable_ircd     #x1B[2m2026-06-30T15:36:08.155441Z#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
1782833768.156 sable_ircd     #x1B[2m2026-06-30T15:36:08.155508Z#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
1782833768.156 sable_ircd     #x1B[2m2026-06-30T15:36:08.155603Z#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
1782833768.156 sable_ircd     #x1B[2m2026-06-30T15:36:08.155779Z#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
1782833768.156 sable_ircd     #x1B[2m2026-06-30T15:36:08.155833Z#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 alice"
1782833768.156 S -> alice: :My.Little.Server NOTICE * :*** Looking up your hostname
1782833768.156 sable_ircd     #x1B[2m2026-06-30T15:36:08.155952Z#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
1782833768.156 sable_ircd     #x1B[2m2026-06-30T15:36:08.156001Z#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"
1782833768.156 sable_ircd     #x1B[2m2026-06-30T15:36:08.156078Z#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: 552, tv_nsec: 379221168 }, 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
1782833768.156 sable_ircd     #x1B[2m2026-06-30T15:36:08.156178Z#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: 552, tv_nsec: 379221168 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("alice")), 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
1782833768.156 sable_ircd     #x1B[2m2026-06-30T15:36:08.156223Z#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
1782833768.157 sable_ircd     #x1B[2m2026-06-30T15:36:08.156778Z#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
1782833768.157 sable_ircd     #x1B[2m2026-06-30T15:36:08.156816Z#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"))
1782833768.157 sable_ircd     #x1B[2m2026-06-30T15:36:08.156855Z#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
1782833768.157 sable_ircd     #x1B[2m2026-06-30T15:36:08.156891Z#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: 552, tv_nsec: 379221168 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("alice")), 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
1782833768.157 sable_ircd     #x1B[2m2026-06-30T15:36:08.156955Z#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))
1782833768.157 sable_ircd     #x1B[2m2026-06-30T15:36:08.157186Z#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(859819603528781827)), timestamp: 1782833768, clock: EventClock(1 => 859819600143978498), target: User(UserId(Snowflake(859819603528781826))), details: NewUser(NewUser { nickname: Nickname("alice"), 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(859819603528781827)), NewUserConnection { user: UserId(Snowflake(859819603528781826)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833768 })) }) }; event clock=EventClock(1 => 859819600143978498) my clock=EventClock(1 => 859819600143978498)
1782833768.157 S -> alice: :My.Little.Server NOTICE * :*** Found your hostname: localhost1782833768.157 sable_ircd     #x1B[2m2026-06-30T15:36:08.157315Z#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

1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157635Z#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(859819603528781827)), timestamp: 1782833768, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819603528781826)), 1) }), users_to_notify: [] })
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157667Z#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(859819603528781827)), timestamp: 1782833768, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819603528781826)), 1) }), users_to_notify: [] }
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157708Z#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(859819603528781827)), timestamp: 1782833768, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819603528781826)), 2), connection: UserConnectionId(Snowflake(859819603528781827)) }), users_to_notify: [] })
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157731Z#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(859819603528781827)), timestamp: 1782833768, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819603528781826)), 2), connection: UserConnectionId(Snowflake(859819603528781827)) }), users_to_notify: [] }
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157774Z#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 alice :Welcome to the test Internet Relay Chat network, alice
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157800Z#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 alice :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157822Z#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 alice :This server was created 2026-06-30 15:36:08.157814481 UTC
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157840Z#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 alice My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157861Z#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 alice 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
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157879Z#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 alice :MOTD File is missing
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157902Z#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): :alice!username@localhost MODE alice +
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157918Z#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 alice :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157961Z#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(859819603528781827)), timestamp: 1782833768, change: EventComplete(EventComplete), users_to_notify: [] })
1782833768.158 sable_ircd     #x1B[2m2026-06-30T15:36:08.157984Z#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(859819603528781827)), timestamp: 1782833768, change: EventComplete(EventComplete), users_to_notify: [] }
1782833768.158 S -> alice: :My.Little.Server 001 alice :Welcome to the test Internet Relay Chat network, alice
1782833768.158 S -> alice: :My.Little.Server 002 alice :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1782833768.158 alice -> S: PING foo
1782833768.159 sable_ircd     #x1B[2m2026-06-30T15:36:08.158537Z#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
1782833768.159 sable_ircd     #x1B[2m2026-06-30T15:36:08.158578Z#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"
1782833768.159 sable_ircd     #x1B[2m2026-06-30T15:36:08.158646Z#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
1782833768.359 alice -> S: PING synchronize552.582241495
1782833768.359 S -> alice: :My.Little.Server 003 alice :This server was created 2026-06-30 15:36:08.157814481 UTC
1782833768.359 S -> alice: :My.Little.Server 004 alice My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1782833768.359 S -> alice: :My.Little.Server 005 alice 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
1782833768.359 S -> alice: :My.Little.Server 422 alice :MOTD File is missing
1782833768.359 S -> alice: :alice!username@localhost MODE alice +
1782833768.359 S -> alice: :My.Little.Server NOTICE alice :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1782833768.359 S -> alice: :My.Little.Server PONG My.Little.Server :foo
1782833768.359 sable_ircd     #x1B[2m2026-06-30T15:36:08.359275Z#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
1782833768.359 sable_ircd     #x1B[2m2026-06-30T15:36:08.359339Z#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 synchronize552.582241495"
1782833768.360 sable_ircd     #x1B[2m2026-06-30T15:36:08.359503Z#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 :synchronize552.582241495
1782833768.360 S -> alice: :My.Little.Server PONG My.Little.Server :synchronize552.582241495
1782833768.961 bob: connects to server.
1782833768.961 bob -> S: NICK bob
1782833768.961 bob -> S: USER username * * :Realname
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.961434Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 4), remote_addr: 127.0.0.1, tls_info: None }
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.961591Z#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
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.961650Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.961736Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Looking up your hostname
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.961889Z#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
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.961951Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK bob"
1782833768.962 S -> bob: :My.Little.Server NOTICE * :*** Looking up your hostname
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.962151Z#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: 553, tv_nsec: 185354756 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("bob")), 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
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.962213Z#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
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.962249Z#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
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.962278Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER username * * :Realname"
1782833768.962 sable_ircd     #x1B[2m2026-06-30T15:36:08.962347Z#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: 553, tv_nsec: 185354756 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("bob")), 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
1782833768.963 sable_ircd     #x1B[2m2026-06-30T15:36:08.962936Z#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
1782833768.963 sable_ircd     #x1B[2m2026-06-30T15:36:08.962973Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 4): 127.0.0.1/Some(Hostname("localhost"))
1782833768.963 sable_ircd     #x1B[2m2026-06-30T15:36:08.963017Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Found your hostname: localhost
1782833768.963 sable_ircd     #x1B[2m2026-06-30T15:36:08.963055Z#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: 553, tv_nsec: 185354756 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("bob")), 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
1782833768.963 sable_ircd     #x1B[2m2026-06-30T15:36:08.963119Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mRegisterClient(ConnectionId(ListenerId(0), 4))
1782833768.963 sable_ircd     #x1B[2m2026-06-30T15:36:08.963403Z#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(859819606909390852)), timestamp: 1782833768, clock: EventClock(1 => 859819603528781827), target: User(UserId(Snowflake(859819606909390852))), details: NewUser(NewUser { nickname: Nickname("bob"), 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(859819606909390853)), NewUserConnection { user: UserId(Snowflake(859819606909390852)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833768 })) }) }; event clock=EventClock(1 => 859819603528781827) my clock=EventClock(1 => 859819603528781827)
1782833768.964 S -> bob: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.963520Z#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
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.963822Z#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(859819606909390852)), timestamp: 1782833768, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819606909390852)), 1) }), users_to_notify: [] })
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.963863Z#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(859819606909390852)), timestamp: 1782833768, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(859819606909390852)), 1) }), users_to_notify: [] }
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.963920Z#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(859819606909390852)), timestamp: 1782833768, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819606909390852)), 2), connection: UserConnectionId(Snowflake(859819606909390853)) }), users_to_notify: [] })
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.963944Z#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(859819606909390852)), timestamp: 1782833768, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(859819606909390852)), 2), connection: UserConnectionId(Snowflake(859819606909390853)) }), users_to_notify: [] }
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.963989Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 001 bob :Welcome to the test Internet Relay Chat network, bob
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.964015Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 002 bob :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.964041Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 003 bob :This server was created 2026-06-30 15:36:08.964031729 UTC
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.964059Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 004 bob My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.964081Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 005 bob 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
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.964095Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 422 bob :MOTD File is missing
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.964111Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :bob!username@localhost MODE bob +
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.964122Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE bob :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.964169Z#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(859819606909390852)), timestamp: 1782833768, change: EventComplete(EventComplete), users_to_notify: [] })
1782833768.964 sable_ircd     #x1B[2m2026-06-30T15:36:08.964192Z#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(859819606909390852)), timestamp: 1782833768, change: EventComplete(EventComplete), users_to_notify: [] }
1782833768.964 S -> bob: :My.Little.Server 001 bob :Welcome to the test Internet Relay Chat network, bob
1782833768.964 bob -> S: PING foo
1782833768.965 sable_ircd     #x1B[2m2026-06-30T15:36:08.964750Z#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
1782833768.965 sable_ircd     #x1B[2m2026-06-30T15:36:08.964788Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING foo"
1782833768.965 sable_ircd     #x1B[2m2026-06-30T15:36:08.964854Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :foo
1782833769.065 bob -> S: PING synchronize553.288284136
1782833769.065 S -> bob: :My.Little.Server 002 bob :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1782833769.065 S -> bob: :My.Little.Server 003 bob :This server was created 2026-06-30 15:36:08.964031729 UTC
1782833769.065 S -> bob: :My.Little.Server 004 bob My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1782833769.065 S -> bob: :My.Little.Server 005 bob 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
1782833769.065 S -> bob: :My.Little.Server 422 bob :MOTD File is missing
1782833769.065 S -> bob: :bob!username@localhost MODE bob +
1782833769.065 S -> bob: :My.Little.Server NOTICE bob :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1782833769.065 S -> bob: :My.Little.Server PONG My.Little.Server :foo
1782833769.065 sable_ircd     #x1B[2m2026-06-30T15:36:09.065332Z#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
1782833769.065 sable_ircd     #x1B[2m2026-06-30T15:36:09.065436Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize553.288284136"
1782833769.066 sable_ircd     #x1B[2m2026-06-30T15:36:09.065558Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :synchronize553.288284136
1782833769.066 S -> bob: :My.Little.Server PONG My.Little.Server :synchronize553.288284136
1782833769.767 ircop -> S: OPER operuser operpassword
1782833769.768 sable_ircd     #x1B[2m2026-06-30T15:36:09.767653Z#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
1782833769.768 sable_ircd     #x1B[2m2026-06-30T15:36:09.767718Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"OPER operuser operpassword"
1782833769.844 sable_ircd     #x1B[2m2026-06-30T15:36:09.843439Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2maudit#x1B[0m#x1B[2m:#x1B[0m #x1B[3mid#x1B[0m#x1B[2m=#x1B[0mAuditLogEntryId(Snowflake(859819610600378374)) #x1B[3mcategory#x1B[0m#x1B[2m=#x1B[0mGeneral #x1B[3mtimestamp#x1B[0m#x1B[2m=#x1B[0m1782833769 #x1B[3msource_id#x1B[0m#x1B[2m=#x1B[0mSome(UserId(Snowflake(859819600143978496))) #x1B[3msource_addr#x1B[0m#x1B[2m=#x1B[0mSome(127.0.0.1) #x1B[3msource_str#x1B[0m#x1B[2m=#x1B[0m"ircop!username@localhost[]{127.0.0.1}" #x1B[3maction#x1B[0m#x1B[2m=#x1B[0m"OPER" #x1B[3mtarget_id#x1B[0m#x1B[2m=#x1B[0mNone
1782833769.844 sable_ircd     #x1B[2m2026-06-30T15:36:09.843523Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 381 ircop :You are now an IRC operator
1782833769.844 sable_ircd     #x1B[2m2026-06-30T15:36:09.843615Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mStateChange(User(UserId(Snowflake(859819600143978496))), OperUp(OperUp { oper_name: "operuser" }))
1782833769.844 sable_ircd     #x1B[2m2026-06-30T15:36:09.843713Z#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(859819610600378373)), timestamp: 1782833769, clock: EventClock(1 => 859819606909390852), target: AuditLogEntry(AuditLogEntryId(Snowflake(859819610600378374))), details: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntry { id: AuditLogEntryId(Snowflake(859819610600378374)), timestamp: 1782833769, category: General, source_id: Some(UserId(Snowflake(859819600143978496))), source_addr: Some(127.0.0.1), source_str: "ircop!username@localhost[]{127.0.0.1}", action: "OPER", target_id: None, target_str: None, target_duration: None, reason: None } }) }; event clock=EventClock(1 => 859819606909390852) my clock=EventClock(1 => 859819606909390852)
1782833769.844 sable_ircd     #x1B[2m2026-06-30T15:36:09.843831Z#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
1782833769.844 sable_ircd     #x1B[2m2026-06-30T15:36:09.843917Z#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(859819610600378374)), timestamp: 1782833769, clock: EventClock(1 => 859819610600378373), target: User(UserId(Snowflake(859819600143978496))), details: OperUp(OperUp { oper_name: "operuser" }) }; event clock=EventClock(1 => 859819610600378373) my clock=EventClock(1 => 859819610600378373)
1782833769.844 sable_ircd     #x1B[2m2026-06-30T15:36:09.843996Z#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
1782833769.844 sable_ircd     #x1B[2m2026-06-30T15:36:09.844388Z#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(859819610600378373)), timestamp: 1782833769, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(859819610600378374)) }), users_to_notify: [] })
1782833769.844 sable_ircd     #x1B[2m2026-06-30T15:36:09.844428Z#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(859819610600378373)), timestamp: 1782833769, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(859819610600378374)) }), users_to_notify: [] }
1782833769.845 sable_ircd     #x1B[2m2026-06-30T15:36:09.844474Z#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(859819610600378373)), timestamp: 1782833769, change: EventComplete(EventComplete), users_to_notify: [] })
1782833769.845 sable_ircd     #x1B[2m2026-06-30T15:36:09.844497Z#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(859819610600378373)), timestamp: 1782833769, change: EventComplete(EventComplete), users_to_notify: [] }
1782833769.845 sable_ircd     #x1B[2m2026-06-30T15:36:09.844541Z#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(859819610600378374)), timestamp: 1782833769, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(859819600143978496)), 2), added: UserModeSet(2), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(859819600143978496)), 2)) }), users_to_notify: [UserId(Snowflake(859819600143978496))] })
1782833769.845 sable_ircd     #x1B[2m2026-06-30T15:36:09.844571Z#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(859819610600378374)), timestamp: 1782833769, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(859819600143978496)), 2), added: UserModeSet(2), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(859819600143978496)), 2)) }), users_to_notify: [UserId(Snowflake(859819600143978496))] }
1782833769.845 sable_ircd     #x1B[2m2026-06-30T15:36:09.844631Z#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): :ircop!username@localhost MODE ircop +o
1782833769.845 sable_ircd     #x1B[2m2026-06-30T15:36:09.844692Z#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(859819610600378374)), timestamp: 1782833769, change: EventComplete(EventComplete), users_to_notify: [] })
1782833769.845 sable_ircd     #x1B[2m2026-06-30T15:36:09.844720Z#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(859819610600378374)), timestamp: 1782833769, change: EventComplete(EventComplete), users_to_notify: [] }
1782833769.867 ircop -> S: PING synchronize554.090947682
1782833769.867 S -> ircop: :My.Little.Server 381 ircop :You are now an IRC operator
1782833769.868 S -> ircop: :ircop!username@localhost MODE ircop +o
1782833769.868 sable_ircd     #x1B[2m2026-06-30T15:36:09.867867Z#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
1782833769.868 sable_ircd     #x1B[2m2026-06-30T15:36:09.867927Z#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 synchronize554.090947682"
1782833769.868 sable_ircd     #x1B[2m2026-06-30T15:36:09.868052Z#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 :synchronize554.090947682
1782833769.868 S -> ircop: :My.Little.Server PONG My.Little.Server :synchronize554.090947682
1782833769.868 alice -> S: KILL bob :some arbitrary reason
1782833769.869 sable_ircd     #x1B[2m2026-06-30T15:36:09.868652Z#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
1782833769.869 sable_ircd     #x1B[2m2026-06-30T15:36:09.868692Z#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"KILL bob :some arbitrary reason"
1782833769.869 sable_ircd     #x1B[2m2026-06-30T15:36:09.868781Z#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 481 alice :You're not an IRC operator
1782833769.969 alice -> S: PING synchronize554.192201148
1782833769.969 S -> alice: :My.Little.Server 481 alice :You're not an IRC operator
1782833769.969 sable_ircd     #x1B[2m2026-06-30T15:36:09.969142Z#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
1782833769.969 sable_ircd     #x1B[2m2026-06-30T15:36:09.969207Z#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 synchronize554.192201148"
1782833770.221 sable_ircd     #x1B[2m2026-06-30T15:36:10.220871Z#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 :synchronize554.192201148
1782833770.221 S -> alice: :My.Little.Server PONG My.Little.Server :synchronize554.192201148
1782833770.321 bob -> S: PING synchronize554.544991768
1782833770.322 sable_ircd     #x1B[2m2026-06-30T15:36:10.321795Z#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
1782833770.322 sable_ircd     #x1B[2m2026-06-30T15:36:10.321848Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize554.544991768"
1782833770.322 sable_ircd     #x1B[2m2026-06-30T15:36:10.321943Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server PONG My.Little.Server :synchronize554.544991768
1782833770.322 S -> bob: :My.Little.Server PONG My.Little.Server :synchronize554.544991768
1782833770.322 alice -> S: KILL alice :some arbitrary reason
1782833770.323 sable_ircd     #x1B[2m2026-06-30T15:36:10.322599Z#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
1782833770.323 sable_ircd     #x1B[2m2026-06-30T15:36:10.322640Z#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"KILL alice :some arbitrary reason"
1782833770.423 alice -> S: PING synchronize554.646080545
1782833770.423 sable_ircd     #x1B[2m2026-06-30T15:36:10.423041Z#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
1782833770.423 sable_ircd     #x1B[2m2026-06-30T15:36:10.423105Z#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 synchronize554.646080545"
1782833771.177 sable_ircd     #x1B[2m2026-06-30T15:36:11.177288Z#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 481 alice :You're not an IRC operator
1782833771.178 S -> alice: :My.Little.Server 481 alice :You're not an IRC operator
1782833772.179 alice: waiting…
1782833772.182 sable_ircd     #x1B[2m2026-06-30T15:36:12.182287Z#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 :synchronize554.646080545
1782833772.183 S -> alice: :My.Little.Server PONG My.Little.Server :synchronize554.646080545
1782833772.283 alice -> S: PING synchronize556.506702294
1782833772.284 sable_ircd     #x1B[2m2026-06-30T15:36:12.283723Z#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
1782833772.284 sable_ircd     #x1B[2m2026-06-30T15:36:12.283800Z#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 synchronize556.506702294"
1782833773.038 sable_ircd     #x1B[2m2026-06-30T15:36:13.037959Z#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 :synchronize556.506702294
1782833773.039 S -> alice: :My.Little.Server PONG My.Little.Server :synchronize556.506702294
1782833773.039 ircop -> S: KILL alice :some arbitrary reason
1782833773.039 sable_ircd     #x1B[2m2026-06-30T15:36:13.038973Z#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
1782833773.039 sable_ircd     #x1B[2m2026-06-30T15:36:13.039018Z#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"KILL alice :some arbitrary reason"
1782833773.039 sable_ircd     #x1B[2m2026-06-30T15:36:13.039122Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2maudit#x1B[0m#x1B[2m:#x1B[0m #x1B[3mid#x1B[0m#x1B[2m=#x1B[0mAuditLogEntryId(Snowflake(859819624005373959)) #x1B[3mcategory#x1B[0m#x1B[2m=#x1B[0mGeneral #x1B[3mtimestamp#x1B[0m#x1B[2m=#x1B[0m1782833773 #x1B[3msource_id#x1B[0m#x1B[2m=#x1B[0mSome(UserId(Snowflake(859819600143978496))) #x1B[3msource_addr#x1B[0m#x1B[2m=#x1B[0mSome(127.0.0.1) #x1B[3msource_str#x1B[0m#x1B[2m=#x1B[0m"ircop!username@localhost[]{127.0.0.1}" #x1B[3maction#x1B[0m#x1B[2m=#x1B[0m"KILL" #x1B[3mtarget_id#x1B[0m#x1B[2m=#x1B[0mSome(UserId(Snowflake(859819603528781826))) #x1B[3mtarget_str#x1B[0m#x1B[2m=#x1B[0m"alice!username@localhost[]" #x1B[3mreason#x1B[0m#x1B[2m=#x1B[0m"some arbitrary reason"
1782833773.039 sable_ircd     #x1B[2m2026-06-30T15:36:13.039225Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mStateChange(User(UserId(Snowflake(859819603528781826))), UserQuit(UserQuit { message: "Killed by ircop (some arbitrary reason)" }))
1782833773.039 sable_ircd     #x1B[2m2026-06-30T15:36:13.039332Z#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(859819624005373959)), timestamp: 1782833773, clock: EventClock(1 => 859819610600378374), target: AuditLogEntry(AuditLogEntryId(Snowflake(859819624005373959))), details: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntry { id: AuditLogEntryId(Snowflake(859819624005373959)), timestamp: 1782833773, category: General, source_id: Some(UserId(Snowflake(859819600143978496))), source_addr: Some(127.0.0.1), source_str: "ircop!username@localhost[]{127.0.0.1}", action: "KILL", target_id: Some(UserId(Snowflake(859819603528781826))), target_str: Some("alice!username@localhost[]"), target_duration: None, reason: Some("some arbitrary reason") } }) }; event clock=EventClock(1 => 859819610600378374) my clock=EventClock(1 => 859819610600378374)
1782833773.039 sable_ircd     #x1B[2m2026-06-30T15:36:13.039430Z#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
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.039492Z#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(859819624005373960)), timestamp: 1782833773, clock: EventClock(1 => 859819624005373959), target: User(UserId(Snowflake(859819603528781826))), details: UserQuit(UserQuit { message: "Killed by ircop (some arbitrary reason)" }) }; event clock=EventClock(1 => 859819624005373959) my clock=EventClock(1 => 859819624005373959)
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.039526Z#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
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.039771Z#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(859819624005373959)), timestamp: 1782833773, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(859819624005373959)) }), users_to_notify: [] })
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.039817Z#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(859819624005373959)), timestamp: 1782833773, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(859819624005373959)) }), users_to_notify: [] }
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.039889Z#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(859819624005373959)), timestamp: 1782833773, change: EventComplete(EventComplete), users_to_notify: [] })
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.039931Z#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(859819624005373959)), timestamp: 1782833773, change: EventComplete(EventComplete), users_to_notify: [] }
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.039979Z#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(859819624005373960)), timestamp: 1782833773, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(859819603528781826)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(859819603528781827)), user: UserId(Snowflake(859819603528781826)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833768 } }), users_to_notify: [] })
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.040008Z#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(859819624005373960)), timestamp: 1782833773, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(859819603528781826)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(859819603528781827)), user: UserId(Snowflake(859819603528781826)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833768 } }), users_to_notify: [] }
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.040078Z#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(859819624005373960)), timestamp: 1782833773, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(859819603528781826)), 2), nickname: Nickname("alice"), message: "Killed by ircop (some arbitrary reason)", memberships: [] }), users_to_notify: [] })
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.040106Z#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(859819624005373960)), timestamp: 1782833773, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(859819603528781826)), 2), nickname: Nickname("alice"), message: "Killed by ircop (some arbitrary reason)", memberships: [] }), users_to_notify: [] }
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.040150Z#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(859819624005373960)), timestamp: 1782833773, change: EventComplete(EventComplete), users_to_notify: [] })
1782833773.040 sable_ircd     #x1B[2m2026-06-30T15:36:13.040172Z#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(859819624005373960)), timestamp: 1782833773, change: EventComplete(EventComplete), users_to_notify: [] }
1782833773.041 sable_ircd     #x1B[2m2026-06-30T15:36:13.040570Z#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), 3) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed
1782833773.041 sable_ircd     #x1B[2m2026-06-30T15:36:13.040663Z#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
1782833773.139 ircop -> S: PING synchronize557.362424231
1782833773.140 sable_ircd     #x1B[2m2026-06-30T15:36:13.139446Z#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
1782833773.140 sable_ircd     #x1B[2m2026-06-30T15:36:13.139525Z#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 synchronize557.362424231"
1782833773.140 sable_ircd     #x1B[2m2026-06-30T15:36:13.139664Z#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 :synchronize557.362424231
1782833773.140 S -> ircop: :My.Little.Server PONG My.Little.Server :synchronize557.362424231
1782833773.240 alice -> S: PING synchronize557.463777539
1782833773.240 ircop -> S: KILL bob :some arbitrary reason
1782833773.241 sable_ircd     #x1B[2m2026-06-30T15:36:13.240879Z#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
1782833773.241 sable_ircd     #x1B[2m2026-06-30T15:36:13.240945Z#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"KILL bob :some arbitrary reason"
1782833773.241 sable_ircd     #x1B[2m2026-06-30T15:36:13.241091Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2maudit#x1B[0m#x1B[2m:#x1B[0m #x1B[3mid#x1B[0m#x1B[2m=#x1B[0mAuditLogEntryId(Snowflake(859819624852623368)) #x1B[3mcategory#x1B[0m#x1B[2m=#x1B[0mGeneral #x1B[3mtimestamp#x1B[0m#x1B[2m=#x1B[0m1782833773 #x1B[3msource_id#x1B[0m#x1B[2m=#x1B[0mSome(UserId(Snowflake(859819600143978496))) #x1B[3msource_addr#x1B[0m#x1B[2m=#x1B[0mSome(127.0.0.1) #x1B[3msource_str#x1B[0m#x1B[2m=#x1B[0m"ircop!username@localhost[]{127.0.0.1}" #x1B[3maction#x1B[0m#x1B[2m=#x1B[0m"KILL" #x1B[3mtarget_id#x1B[0m#x1B[2m=#x1B[0mSome(UserId(Snowflake(859819606909390852))) #x1B[3mtarget_str#x1B[0m#x1B[2m=#x1B[0m"bob!username@localhost[]" #x1B[3mreason#x1B[0m#x1B[2m=#x1B[0m"some arbitrary reason"
1782833773.241 sable_ircd     #x1B[2m2026-06-30T15:36:13.241196Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mStateChange(User(UserId(Snowflake(859819606909390852))), UserQuit(UserQuit { message: "Killed by ircop (some arbitrary reason)" }))
1782833773.241 sable_ircd     #x1B[2m2026-06-30T15:36:13.241299Z#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(859819624852623369)), timestamp: 1782833773, clock: EventClock(1 => 859819624005373960), target: AuditLogEntry(AuditLogEntryId(Snowflake(859819624852623368))), details: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntry { id: AuditLogEntryId(Snowflake(859819624852623368)), timestamp: 1782833773, category: General, source_id: Some(UserId(Snowflake(859819600143978496))), source_addr: Some(127.0.0.1), source_str: "ircop!username@localhost[]{127.0.0.1}", action: "KILL", target_id: Some(UserId(Snowflake(859819606909390852))), target_str: Some("bob!username@localhost[]"), target_duration: None, reason: Some("some arbitrary reason") } }) }; event clock=EventClock(1 => 859819624005373960) my clock=EventClock(1 => 859819624005373960)
1782833773.241 sable_ircd     #x1B[2m2026-06-30T15:36:13.241406Z#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
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.241476Z#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(859819624852623370)), timestamp: 1782833773, clock: EventClock(1 => 859819624852623369), target: User(UserId(Snowflake(859819606909390852))), details: UserQuit(UserQuit { message: "Killed by ircop (some arbitrary reason)" }) }; event clock=EventClock(1 => 859819624852623369) my clock=EventClock(1 => 859819624852623369)
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.241512Z#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
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.241677Z#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(859819624852623369)), timestamp: 1782833773, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(859819624852623368)) }), users_to_notify: [] })
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.241729Z#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(859819624852623369)), timestamp: 1782833773, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(859819624852623368)) }), users_to_notify: [] }
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.241798Z#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(859819624852623369)), timestamp: 1782833773, change: EventComplete(EventComplete), users_to_notify: [] })
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.241831Z#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(859819624852623369)), timestamp: 1782833773, change: EventComplete(EventComplete), users_to_notify: [] }
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.241899Z#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(859819624852623370)), timestamp: 1782833773, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(859819606909390852)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(859819606909390853)), user: UserId(Snowflake(859819606909390852)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833768 } }), users_to_notify: [] })
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.241938Z#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(859819624852623370)), timestamp: 1782833773, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(859819606909390852)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(859819606909390853)), user: UserId(Snowflake(859819606909390852)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1782833768 } }), users_to_notify: [] }
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.242025Z#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(859819624852623370)), timestamp: 1782833773, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(859819606909390852)), 2), nickname: Nickname("bob"), message: "Killed by ircop (some arbitrary reason)", memberships: [] }), users_to_notify: [] })
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.242063Z#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(859819624852623370)), timestamp: 1782833773, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(859819606909390852)), 2), nickname: Nickname("bob"), message: "Killed by ircop (some arbitrary reason)", memberships: [] }), users_to_notify: [] }
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.242121Z#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(859819624852623370)), timestamp: 1782833773, change: EventComplete(EventComplete), users_to_notify: [] })
1782833773.242 sable_ircd     #x1B[2m2026-06-30T15:36:13.242156Z#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(859819624852623370)), timestamp: 1782833773, change: EventComplete(EventComplete), users_to_notify: [] }
1782833773.243 sable_ircd     #x1B[2m2026-06-30T15:36:13.242580Z#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), 4) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed
1782833773.243 sable_ircd     #x1B[2m2026-06-30T15:36:13.242670Z#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
1782833773.341 ircop -> S: PING synchronize557.564183097
1782833773.341 sable_ircd     #x1B[2m2026-06-30T15:36:13.341028Z#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
1782833773.341 sable_ircd     #x1B[2m2026-06-30T15:36:13.341108Z#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 synchronize557.564183097"
1782833773.341 sable_ircd     #x1B[2m2026-06-30T15:36:13.341261Z#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 :synchronize557.564183097
1782833773.342 S -> ircop: :My.Little.Server PONG My.Little.Server :synchronize557.564183097
1782833773.442 bob -> S: PING synchronize557.665435877
1782833773.445 ircop: disconnects from server.