--------------------------------- Captured Out ---------------------------------
---- new test ----
1788127723.124 sable_ircd     uid=1001
1788127723.128 sable_history  #x1B[2m2027-08-30T22:35:49.550219Z#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(1014302452687773728)), timestamp: 1819665349, clock: EventClock(1 => 1014295144268042241, 50 => 1014302201021145119), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665349 }) }; event clock=EventClock(1 => 1014295144268042241, 50 => 1014302201021145119) my clock=EventClock(1 => 1014295144268042241, 50 => 1014302201021145119)
1788127723.128 sable_history  #x1B[2m2027-08-30T22:35:49.552149Z#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
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.127474Z#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(882024060035272704)), timestamp: 1788127723, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127723, name: ServerName("My.Little.Server"), ts: 1788127723, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.127582Z#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
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.127737Z#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(882024060035272704)), timestamp: 1788127723, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1788127723, name: ServerName("My.Little.Server"), ts: 1788127723, 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
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.127878Z#x1B[0m #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(882024060035272704)), timestamp: 1788127723, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.127907Z#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(882024060035272704)), timestamp: 1788127723, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.127945Z#x1B[0m #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(882024060035272704)), timestamp: 1788127723, change: EventComplete(EventComplete), users_to_notify: [] })
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.127963Z#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(882024060035272704)), timestamp: 1788127723, change: EventComplete(EventComplete), users_to_notify: [] }
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.128175Z#x1B[0m #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
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.128221Z#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(882024060039467009)), timestamp: 1788127723, clock: EventClock(1 => 882024060035272704), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1788127723 }) }; event clock=EventClock(1 => 882024060035272704) my clock=EventClock(1 => 882024060035272704)
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.128254Z#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
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.128352Z#x1B[0m #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(882024060039467009)), timestamp: 1788127723, change: EventComplete(EventComplete), users_to_notify: [] })
1788127723.128 sable_ircd     #x1B[2m2026-08-30T22:08:43.128367Z#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(882024060039467009)), timestamp: 1788127723, change: EventComplete(EventComplete), users_to_notify: [] }
1788127723.221 sable_ircd     #x1B[2m2026-08-30T22:08:43.221205Z#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 }
1788127723.221 sable_ircd     #x1B[2m2026-08-30T22:08:43.221338Z#x1B[0m #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
1788127723.221 sable_ircd     #x1B[2m2026-08-30T22:08:43.221417Z#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
1788127723.222 sable_ircd     #x1B[2m2026-08-30T22:08:43.221480Z#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
1788127723.222 sable_ircd     #x1B[2m2026-08-30T22:08:43.221611Z#x1B[0m #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
1788127723.222 sable_ircd     #x1B[2m2026-08-30T22:08:43.221656Z#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"
1788127723.222 sable_ircd     #x1B[2m2026-08-30T22:08:43.221742Z#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
1788127723.222 sable_ircd     #x1B[2m2026-08-30T22:08:43.221811Z#x1B[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))
1788127723.222 sable_ircd     #x1B[2m2026-08-30T22:08:43.221835Z#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)
1788127723.222 sable_ircd     #x1B[2m2026-08-30T22:08:43.222131Z#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
1788127723.222 sable_ircd     #x1B[2m2026-08-30T22:08:43.222191Z#x1B[0m #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
1788127723.222 sable_ircd     #x1B[2m2026-08-30T22:08:43.222343Z#x1B[0m #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
1788127723.242 1: connects to server.
1788127723.242 1 -> S: NICK foo
1788127723.242 1 -> S: USER username * * :Realname
1788127723.242 sable_ircd     #x1B[2m2026-08-30T22:08:43.242278Z#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 }
1788127723.242 sable_ircd     #x1B[2m2026-08-30T22:08:43.242402Z#x1B[0m #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
1788127723.242 sable_ircd     #x1B[2m2026-08-30T22:08:43.242438Z#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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.242487Z#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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.242588Z#x1B[0m #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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.242621Z#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 foo"
1788127723.243 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.242753Z#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: 369, tv_nsec: 364091359 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("foo")), 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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.242801Z#x1B[0m #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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.242821Z#x1B[0m #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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.242840Z#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"
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.242887Z#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: 369, tv_nsec: 364091359 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("foo")), 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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.243211Z#x1B[0m #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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.243239Z#x1B[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"))
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.243258Z#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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.243272Z#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: 369, tv_nsec: 364091359 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("foo")), 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
1788127723.243 sable_ircd     #x1B[2m2026-08-30T22:08:43.243308Z#x1B[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))
1788127723.244 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243547Z#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(882024060521811970)), timestamp: 1788127723, clock: EventClock(1 => 882024060039467009), target: User(UserId(Snowflake(882024060521811968))), details: NewUser(NewUser { nickname: Nickname("foo"), 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(882024060521811969)), NewUserConnection { user: UserId(Snowflake(882024060521811968)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127723 })) }) }; event clock=EventClock(1 => 882024060039467009) my clock=EventClock(1 => 882024060039467009)
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243617Z#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
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243821Z#x1B[0m #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(882024060521811970)), timestamp: 1788127723, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024060521811968)), 1) }), users_to_notify: [] })
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243856Z#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(882024060521811970)), timestamp: 1788127723, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024060521811968)), 1) }), users_to_notify: [] }
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243887Z#x1B[0m #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(882024060521811970)), timestamp: 1788127723, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024060521811968)), 2), connection: UserConnectionId(Snowflake(882024060521811969)) }), users_to_notify: [] })
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243900Z#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(882024060521811970)), timestamp: 1788127723, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024060521811968)), 2), connection: UserConnectionId(Snowflake(882024060521811969)) }), users_to_notify: [] }
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243933Z#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 foo :Welcome to the test Internet Relay Chat network, foo
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243947Z#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 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243961Z#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 foo :This server was created 2026-08-30 22:08:43.243954876 UTC
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243971Z#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 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.243990Z#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 foo 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
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.244002Z#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 foo :MOTD File is missing
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.244012Z#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): :foo!username@localhost MODE foo +
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.244022Z#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 foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.244038Z#x1B[0m #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(882024060521811970)), timestamp: 1788127723, change: EventComplete(EventComplete), users_to_notify: [] })
1788127723.244 sable_ircd     #x1B[2m2026-08-30T22:08:43.244049Z#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(882024060521811970)), timestamp: 1788127723, change: EventComplete(EventComplete), users_to_notify: [] }
1788127723.244 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo
1788127723.244 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127723.244 S -> 1: :My.Little.Server 003 foo :This server was created 2026-08-30 22:08:43.243954876 UTC
1788127723.244 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127723.244 S -> 1: :My.Little.Server 005 foo 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
1788127723.244 S -> 1: :My.Little.Server 422 foo :MOTD File is missing
1788127723.244 S -> 1: :foo!username@localhost MODE foo +
1788127723.244 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127723.244 1 -> S: PING foo
1788127723.245 sable_ircd     #x1B[2m2026-08-30T22:08:43.244560Z#x1B[0m #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
1788127723.245 sable_ircd     #x1B[2m2026-08-30T22:08:43.244588Z#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"
1788127723.245 sable_ircd     #x1B[2m2026-08-30T22:08:43.244637Z#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
1788127723.632 sable_history  #x1B[2m2027-08-30T22:47:02.100764Z#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(1014305273566928941)), timestamp: 1819666022, clock: EventClock(1 => 1014295448346693654, 50 => 1014305021908688940, 99 => 1014295451547348996), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666022 }) }; event clock=EventClock(1 => 1014295448346693654, 50 => 1014305021908688940, 99 => 1014295451547348996) my clock=EventClock(1 => 1014295448346693654, 50 => 1014305021908688940, 99 => 1014295451547348996)
1788127723.632 sable_history  #x1B[2m2027-08-30T22:47:02.102196Z#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
1788127723.649 sable_history  #x1B[2m2027-08-30T22:35:50.148069Z#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(1014302455195967521)), timestamp: 1819665350, clock: EventClock(1 => 1014295224354082831, 50 => 1014302203537727520, 99 => 1014295214413983748), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665350 }) }; event clock=EventClock(1 => 1014295224354082831, 50 => 1014302203537727520, 99 => 1014295214413983748) my clock=EventClock(1 => 1014295224354082831, 50 => 1014302203537727520, 99 => 1014295214413983748)
1788127723.649 sable_history  #x1B[2m2027-08-30T22:35:50.149136Z#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
1788127724.045 1 -> S: PING synchronize370.166892594
1788127724.045 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1788127724.046 sable_ircd     #x1B[2m2026-08-30T22:08:44.045859Z#x1B[0m #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
1788127724.046 sable_ircd     #x1B[2m2026-08-30T22:08:44.045917Z#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 synchronize370.166892594"
1788127724.046 sable_ircd     #x1B[2m2026-08-30T22:08:44.046039Z#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 :synchronize370.166892594
1788127724.046 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize370.166892594
1788127724.046 1 -> S: JOIN #chan
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.046519Z#x1B[0m #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
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.046548Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"JOIN #chan"
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.046735Z#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(882024063889838083)), timestamp: 1788127724, clock: EventClock(1 => 882024060521811970), target: Channel(ChannelId(Snowflake(882024063889838082))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 882024060521811970) my clock=EventClock(1 => 882024060521811970)
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.046847Z#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
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.046910Z#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(882024063889838084)), timestamp: 1788127724, clock: EventClock(1 => 882024063889838083), target: Membership(MembershipId(UserId(Snowflake(882024060521811968)), ChannelId(Snowflake(882024063889838082)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024063889838082)), user: UserId(Snowflake(882024060521811968)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 882024063889838083) my clock=EventClock(1 => 882024063889838083)
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.046993Z#x1B[0m #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
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.047040Z#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
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.047091Z#x1B[0m #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(882024063889838083)), timestamp: 1788127724, change: EventComplete(EventComplete), users_to_notify: [] })
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.047117Z#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(882024063889838083)), timestamp: 1788127724, change: EventComplete(EventComplete), users_to_notify: [] }
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.047245Z#x1B[0m #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(882024063889838084)), timestamp: 1788127724, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024060521811968)), ChannelId(Snowflake(882024063889838082))), user: HistoricUserId(UserId(Snowflake(882024060521811968)), 2) }), users_to_notify: [UserId(Snowflake(882024060521811968))] })
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.047275Z#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(882024063889838084)), timestamp: 1788127724, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024060521811968)), ChannelId(Snowflake(882024063889838082))), user: HistoricUserId(UserId(Snowflake(882024060521811968)), 2) }), users_to_notify: [UserId(Snowflake(882024060521811968))] }
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.047332Z#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): :foo!username@localhost JOIN #chan
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.047364Z#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): :foo!username@localhost MODE #chan +o foo
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.047418Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 353 foo = #chan :@foo
1788127724.047 sable_ircd     #x1B[2m2026-08-30T22:08:44.047438Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 366 foo #chan :End of names list
1788127724.048 sable_ircd     #x1B[2m2026-08-30T22:08:44.047482Z#x1B[0m #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(882024063889838084)), timestamp: 1788127724, change: EventComplete(EventComplete), users_to_notify: [] })
1788127724.048 sable_ircd     #x1B[2m2026-08-30T22:08:44.047501Z#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(882024063889838084)), timestamp: 1788127724, change: EventComplete(EventComplete), users_to_notify: [] }
1788127724.147 1 -> S: PING synchronize370.268071846
1788127724.147 S -> 1: :foo!username@localhost JOIN #chan
1788127724.147 S -> 1: :foo!username@localhost MODE #chan +o foo
1788127724.147 S -> 1: :My.Little.Server 353 foo = #chan :@foo
1788127724.147 S -> 1: :My.Little.Server 366 foo #chan :End of names list
1788127724.147 sable_ircd     #x1B[2m2026-08-30T22:08:44.146997Z#x1B[0m #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
1788127724.147 sable_ircd     #x1B[2m2026-08-30T22:08:44.147056Z#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 synchronize370.268071846"
1788127724.509 sable_history  #x1B[2m2027-08-30T22:49:51.009525Z#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(1014305982022623280)), timestamp: 1819666191, clock: EventClock(1 => 1014295401760559126, 50 => 1014305730364383279, 99 => 1014295404927660036), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666191 }) }; event clock=EventClock(1 => 1014295401760559126, 50 => 1014305730364383279, 99 => 1014295404927660036) my clock=EventClock(1 => 1014295401760559126, 50 => 1014305730364383279, 99 => 1014295404927660036)
1788127724.509 sable_history  #x1B[2m2027-08-30T22:49:51.010977Z#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
1788127724.899 sable_history  #x1B[2m2027-08-30T22:39:35.382940Z#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(1014303399900028965)), timestamp: 1819665575, clock: EventClock(1 => 1014295842380582945, 50 => 1014303148241788964, 99 => 1014295842997547013), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665575 }) }; event clock=EventClock(1 => 1014295842380582945, 50 => 1014303148241788964, 99 => 1014295842997547013) my clock=EventClock(1 => 1014295842380582945, 50 => 1014303148241788964, 99 => 1014295842997547013)
1788127724.899 sable_history  #x1B[2m2027-08-30T22:39:35.384479Z#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
1788127725.126 sable_history  #x1B[2m2027-08-30T22:52:40.339605Z#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(1014306692244119603)), timestamp: 1819666360, clock: EventClock(1 => 1014295353727389718, 50 => 1014306440590073906, 99 => 1014295356898684932), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666360 }) }; event clock=EventClock(1 => 1014295353727389718, 50 => 1014306440590073906, 99 => 1014295356898684932) my clock=EventClock(1 => 1014295353727389718, 50 => 1014306440590073906, 99 => 1014295356898684932)
1788127725.126 sable_history  #x1B[2m2027-08-30T22:52:40.341024Z#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
1788127725.137 sable_history  #x1B[2m2027-08-30T22:36:47.716197Z#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(1014302696653660193)), timestamp: 1819665407, clock: EventClock(1 => 1014295135892017153, 50 => 1014302444999614496), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665407 }) }; event clock=EventClock(1 => 1014295135892017153, 50 => 1014302444999614496) my clock=EventClock(1 => 1014295135892017153, 50 => 1014302444999614496)
1788127725.137 sable_history  #x1B[2m2027-08-30T22:36:47.717623Z#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
1788127725.148 1: waiting…
1788127725.153 sable_ircd     #x1B[2m2026-08-30T22:08:45.153319Z#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 :synchronize370.268071846
1788127725.154 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize370.268071846
1788127725.154 2: connects to server.
1788127725.154 2 -> S: NICK bar
1788127725.154 2 -> S: USER username * * :Realname
1788127725.154 sable_ircd     #x1B[2m2026-08-30T22:08:45.154154Z#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 }
1788127725.154 sable_ircd     #x1B[2m2026-08-30T22:08:45.154240Z#x1B[0m #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
1788127725.154 sable_ircd     #x1B[2m2026-08-30T22:08:45.154268Z#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
1788127725.154 sable_ircd     #x1B[2m2026-08-30T22:08:45.154313Z#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
1788127725.154 sable_ircd     #x1B[2m2026-08-30T22:08:45.154440Z#x1B[0m #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
1788127725.154 sable_ircd     #x1B[2m2026-08-30T22:08:45.154474Z#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 bar"
1788127725.155 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.154600Z#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: 371, tv_nsec: 275920208 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("bar")), 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
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.154658Z#x1B[0m #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
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.154694Z#x1B[0m #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
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.154722Z#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"
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.154798Z#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: 371, tv_nsec: 275920208 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("bar")), 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
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.155279Z#x1B[0m #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
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.155302Z#x1B[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"))
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.155322Z#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
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.155337Z#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: 371, tv_nsec: 275920208 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("bar")), 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
1788127725.155 sable_ircd     #x1B[2m2026-08-30T22:08:45.155366Z#x1B[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))
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155568Z#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(882024068541321221)), timestamp: 1788127725, clock: EventClock(1 => 882024063889838084), target: User(UserId(Snowflake(882024068541321219))), details: NewUser(NewUser { nickname: Nickname("bar"), 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(882024068541321220)), NewUserConnection { user: UserId(Snowflake(882024068541321219)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127725 })) }) }; event clock=EventClock(1 => 882024063889838084) my clock=EventClock(1 => 882024063889838084)
1788127725.156 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155648Z#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
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155844Z#x1B[0m #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(882024068541321221)), timestamp: 1788127725, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024068541321219)), 1) }), users_to_notify: [] })
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155872Z#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(882024068541321221)), timestamp: 1788127725, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024068541321219)), 1) }), users_to_notify: [] }
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155904Z#x1B[0m #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(882024068541321221)), timestamp: 1788127725, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024068541321219)), 2), connection: UserConnectionId(Snowflake(882024068541321220)) }), users_to_notify: [] })
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155917Z#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(882024068541321221)), timestamp: 1788127725, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024068541321219)), 2), connection: UserConnectionId(Snowflake(882024068541321220)) }), users_to_notify: [] }
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155951Z#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 bar :Welcome to the test Internet Relay Chat network, bar
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155966Z#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 bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155981Z#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 bar :This server was created 2026-08-30 22:08:45.155975278 UTC
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.155992Z#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 bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.156005Z#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 bar 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
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.156017Z#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 bar :MOTD File is missing
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.156029Z#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): :bar!username@localhost MODE bar +
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.156039Z#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 bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.156057Z#x1B[0m #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(882024068541321221)), timestamp: 1788127725, change: EventComplete(EventComplete), users_to_notify: [] })
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.156069Z#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(882024068541321221)), timestamp: 1788127725, change: EventComplete(EventComplete), users_to_notify: [] }
1788127725.156 S -> 2: :My.Little.Server 001 bar :Welcome to the test Internet Relay Chat network, bar
1788127725.156 2 -> S: PING foo
1788127725.156 sable_ircd     #x1B[2m2026-08-30T22:08:45.156458Z#x1B[0m #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
1788127725.157 sable_ircd     #x1B[2m2026-08-30T22:08:45.156487Z#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"
1788127725.157 sable_ircd     #x1B[2m2026-08-30T22:08:45.156537Z#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
1788127725.256 2 -> S: PING synchronize371.378032885
1788127725.257 S -> 2: :My.Little.Server 002 bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127725.257 S -> 2: :My.Little.Server 003 bar :This server was created 2026-08-30 22:08:45.155975278 UTC
1788127725.257 S -> 2: :My.Little.Server 004 bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127725.257 S -> 2: :My.Little.Server 005 bar 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
1788127725.257 S -> 2: :My.Little.Server 422 bar :MOTD File is missing
1788127725.257 S -> 2: :bar!username@localhost MODE bar +
1788127725.257 S -> 2: :My.Little.Server NOTICE bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127725.257 S -> 2: :My.Little.Server PONG My.Little.Server :foo
1788127725.257 sable_ircd     #x1B[2m2026-08-30T22:08:45.256894Z#x1B[0m #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
1788127725.257 sable_ircd     #x1B[2m2026-08-30T22:08:45.256943Z#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 synchronize371.378032885"
1788127725.257 sable_ircd     #x1B[2m2026-08-30T22:08:45.257045Z#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 :synchronize371.378032885
1788127725.257 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize371.378032885
1788127725.637 sable_history  #x1B[2m2027-08-30T22:55:46.047652Z#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(1014307471159926838)), timestamp: 1819666546, clock: EventClock(1 => 1014295552021499922, 50 => 1014307219505881141, 99 => 1014295555868078086), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666546 }) }; event clock=EventClock(1 => 1014295552021499922, 50 => 1014307219505881141, 99 => 1014295555868078086) my clock=EventClock(1 => 1014295552021499922, 50 => 1014307219505881141, 99 => 1014295555868078086)
1788127725.637 sable_history  #x1B[2m2027-08-30T22:55:46.049164Z#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
1788127725.756 sable_history  #x1B[2m2027-08-30T22:36:48.191872Z#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(1014302698650148897)), timestamp: 1819665408, clock: EventClock(1 => 1014295138538622977, 50 => 1014302446987714592), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665408 }) }; event clock=EventClock(1 => 1014295138538622977, 50 => 1014302446987714592) my clock=EventClock(1 => 1014295138538622977, 50 => 1014302446987714592)
1788127725.756 sable_history  #x1B[2m2027-08-30T22:36:48.193571Z#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
1788127725.958 2 -> S: JOIN #chan
1788127725.959 sable_ircd     #x1B[2m2026-08-30T22:08:45.958686Z#x1B[0m #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
1788127725.959 sable_ircd     #x1B[2m2026-08-30T22:08:45.958750Z#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 #chan"
1788127725.964 sable_history  #x1B[2m2027-08-30T22:42:24.671131Z#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(1014304109945364520)), timestamp: 1819665744, clock: EventClock(1 => 1014295541992919062, 50 => 1014303858287124519, 99 => 1014295545160019972), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665744 }) }; event clock=EventClock(1 => 1014295541992919062, 50 => 1014303858287124519, 99 => 1014295545160019972) my clock=EventClock(1 => 1014295541992919062, 50 => 1014303858287124519, 99 => 1014295545160019972)
1788127725.964 sable_history  #x1B[2m2027-08-30T22:42:24.672505Z#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
1788127726.058 2 -> S: PING synchronize372.179908567
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.058712Z#x1B[0m #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
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.058757Z#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 synchronize372.179908567"
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.058980Z#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(882024072328777734)), timestamp: 1788127726, clock: EventClock(1 => 882024068541321221), target: Membership(MembershipId(UserId(Snowflake(882024068541321219)), ChannelId(Snowflake(882024063889838082)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024063889838082)), user: UserId(Snowflake(882024068541321219)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882024068541321221) my clock=EventClock(1 => 882024068541321221)
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.059091Z#x1B[0m #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
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.059138Z#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
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.059335Z#x1B[0m #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(882024072328777734)), timestamp: 1788127726, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024068541321219)), ChannelId(Snowflake(882024063889838082))), user: HistoricUserId(UserId(Snowflake(882024068541321219)), 2) }), users_to_notify: [UserId(Snowflake(882024068541321219)), UserId(Snowflake(882024060521811968))] })
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.059364Z#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(882024072328777734)), timestamp: 1788127726, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024068541321219)), ChannelId(Snowflake(882024063889838082))), user: HistoricUserId(UserId(Snowflake(882024068541321219)), 2) }), users_to_notify: [UserId(Snowflake(882024068541321219)), UserId(Snowflake(882024060521811968))] }
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.059424Z#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): :bar!username@localhost JOIN #chan
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.059460Z#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 bar = #chan :bar @foo
1788127726.059 sable_ircd     #x1B[2m2026-08-30T22:08:46.059472Z#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 bar #chan :End of names list
1788127726.060 sable_ircd     #x1B[2m2026-08-30T22:08:46.059486Z#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): :bar!username@localhost JOIN #chan
1788127726.060 sable_ircd     #x1B[2m2026-08-30T22:08:46.059513Z#x1B[0m #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(882024072328777734)), timestamp: 1788127726, change: EventComplete(EventComplete), users_to_notify: [] })
1788127726.060 sable_ircd     #x1B[2m2026-08-30T22:08:46.059525Z#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(882024072328777734)), timestamp: 1788127726, change: EventComplete(EventComplete), users_to_notify: [] }
1788127726.060 S -> 2: :bar!username@localhost JOIN #chan
1788127726.060 S -> 2: :My.Little.Server 353 bar = #chan :bar @foo
1788127726.060 S -> 2: :My.Little.Server 366 bar #chan :End of names list
1788127726.313 sable_history  #x1B[2m2027-08-30T22:36:48.942538Z#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(1014302701795876897)), timestamp: 1819665408, clock: EventClock(1 => 1014295140782575617, 50 => 1014302450137636896), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665408 }) }; event clock=EventClock(1 => 1014295140782575617, 50 => 1014302450137636896) my clock=EventClock(1 => 1014295140782575617, 50 => 1014302450137636896)
1788127726.313 sable_history  #x1B[2m2027-08-30T22:36:48.944351Z#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
1788127726.700 sable_history  #x1B[2m2027-08-30T22:45:14.293819Z#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(1014304821395791915)), timestamp: 1819665914, clock: EventClock(1 => 1014295494442094614, 50 => 1014304569737551914, 99 => 1014295497634361348), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665914 }) }; event clock=EventClock(1 => 1014295494442094614, 50 => 1014304569737551914, 99 => 1014295497634361348) my clock=EventClock(1 => 1014295494442094614, 50 => 1014304569737551914, 99 => 1014295497634361348)
1788127726.700 sable_history  #x1B[2m2027-08-30T22:45:14.295381Z#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
1788127726.746 sable_history  #x1B[2m2027-08-30T22:36:49.168058Z#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(1014302702743789601)), timestamp: 1819665409, clock: EventClock(1 => 1014295142766481409, 50 => 1014302451085549600), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665409 }) }; event clock=EventClock(1 => 1014295142766481409, 50 => 1014302451085549600) my clock=EventClock(1 => 1014295142766481409, 50 => 1014302451085549600)
1788127726.746 sable_history  #x1B[2m2027-08-30T22:36:49.169589Z#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
1788127727.061 2: waiting…
1788127727.066 sable_ircd     #x1B[2m2026-08-30T22:08:47.065734Z#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 :synchronize372.179908567
1788127727.066 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize372.179908567
1788127727.066 3: connects to server.
1788127727.066 3 -> S: NICK baz
1788127727.066 3 -> S: USER username * * :Realname
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066485Z#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 }
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066563Z#x1B[0m #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
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066591Z#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
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066635Z#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
1788127727.067 S -> 3: :My.Little.Server NOTICE * :*** Looking up your hostname
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066738Z#x1B[0m #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
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066776Z#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 baz"
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066890Z#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: 373, tv_nsec: 188242546 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("baz")), 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
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066935Z#x1B[0m #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
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066962Z#x1B[0m #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
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.066979Z#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"
1788127727.067 sable_ircd     #x1B[2m2026-08-30T22:08:47.067027Z#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: 373, tv_nsec: 188242546 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("baz")), 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
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.067523Z#x1B[0m #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
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.067550Z#x1B[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"))
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.067575Z#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
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.067593Z#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: 373, tv_nsec: 188242546 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("baz")), 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
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.067635Z#x1B[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))
1788127727.068 S -> 3: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.067845Z#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(882024076560830471)), timestamp: 1788127727, clock: EventClock(1 => 882024072328777734), target: User(UserId(Snowflake(882024076560830469))), details: NewUser(NewUser { nickname: Nickname("baz"), 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(882024076560830470)), NewUserConnection { user: UserId(Snowflake(882024076560830469)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127727 })) }) }; event clock=EventClock(1 => 882024072328777734) my clock=EventClock(1 => 882024072328777734)
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.067930Z#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
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068124Z#x1B[0m #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(882024076560830471)), timestamp: 1788127727, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024076560830469)), 1) }), users_to_notify: [] })
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068153Z#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(882024076560830471)), timestamp: 1788127727, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024076560830469)), 1) }), users_to_notify: [] }
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068189Z#x1B[0m #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(882024076560830471)), timestamp: 1788127727, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024076560830469)), 2), connection: UserConnectionId(Snowflake(882024076560830470)) }), users_to_notify: [] })
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068207Z#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(882024076560830471)), timestamp: 1788127727, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024076560830469)), 2), connection: UserConnectionId(Snowflake(882024076560830470)) }), users_to_notify: [] }
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068252Z#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 baz :Welcome to the test Internet Relay Chat network, baz
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068275Z#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 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068301Z#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 baz :This server was created 2026-08-30 22:08:47.068291577 UTC
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068319Z#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 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068345Z#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 baz 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
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068363Z#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 baz :MOTD File is missing
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068399Z#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): :baz!username@localhost MODE baz +
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068419Z#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 baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068463Z#x1B[0m #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(882024076560830471)), timestamp: 1788127727, change: EventComplete(EventComplete), users_to_notify: [] })
1788127727.068 sable_ircd     #x1B[2m2026-08-30T22:08:47.068482Z#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(882024076560830471)), timestamp: 1788127727, change: EventComplete(EventComplete), users_to_notify: [] }
1788127727.069 S -> 3: :My.Little.Server 001 baz :Welcome to the test Internet Relay Chat network, baz
1788127727.069 3 -> S: PING foo
1788127727.069 sable_ircd     #x1B[2m2026-08-30T22:08:47.068886Z#x1B[0m #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
1788127727.069 sable_ircd     #x1B[2m2026-08-30T22:08:47.068916Z#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"
1788127727.069 sable_ircd     #x1B[2m2026-08-30T22:08:47.068966Z#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
1788127727.128 sable_history  #x1B[2m2027-08-30T22:36:49.547873Z#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(1014302704337625121)), timestamp: 1819665409, clock: EventClock(1 => 1014295144268042241, 50 => 1014302452687773728), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665409 }) }; event clock=EventClock(1 => 1014295144268042241, 50 => 1014302452687773728) my clock=EventClock(1 => 1014295144268042241, 50 => 1014302452687773728)
1788127727.128 sable_history  #x1B[2m2027-08-30T22:36:49.549706Z#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
1788127727.169 3 -> S: PING synchronize373.290434953
1788127727.169 S -> 3: :My.Little.Server 002 baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127727.169 S -> 3: :My.Little.Server 003 baz :This server was created 2026-08-30 22:08:47.068291577 UTC
1788127727.169 S -> 3: :My.Little.Server 004 baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127727.169 S -> 3: :My.Little.Server 005 baz 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
1788127727.169 S -> 3: :My.Little.Server 422 baz :MOTD File is missing
1788127727.169 S -> 3: :baz!username@localhost MODE baz +
1788127727.169 S -> 3: :My.Little.Server NOTICE baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127727.169 S -> 3: :My.Little.Server PONG My.Little.Server :foo
1788127727.169 sable_ircd     #x1B[2m2026-08-30T22:08:47.169245Z#x1B[0m #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
1788127727.169 sable_ircd     #x1B[2m2026-08-30T22:08:47.169298Z#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 synchronize373.290434953"
1788127727.169 sable_ircd     #x1B[2m2026-08-30T22:08:47.169442Z#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 :synchronize373.290434953
1788127727.170 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize373.290434953
1788127727.632 sable_history  #x1B[2m2027-08-30T22:48:02.100699Z#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(1014305525225168942)), timestamp: 1819666082, clock: EventClock(1 => 1014295448346693654, 50 => 1014305273566928941, 99 => 1014295451547348996), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666082 }) }; event clock=EventClock(1 => 1014295448346693654, 50 => 1014305273566928941, 99 => 1014295451547348996) my clock=EventClock(1 => 1014295448346693654, 50 => 1014305273566928941, 99 => 1014295451547348996)
1788127727.632 sable_history  #x1B[2m2027-08-30T22:48:02.102121Z#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
1788127727.649 sable_history  #x1B[2m2027-08-30T22:36:50.148122Z#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(1014302706854207522)), timestamp: 1819665410, clock: EventClock(1 => 1014295224354082831, 50 => 1014302455195967521, 99 => 1014295214413983748), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665410 }) }; event clock=EventClock(1 => 1014295224354082831, 50 => 1014302455195967521, 99 => 1014295214413983748) my clock=EventClock(1 => 1014295224354082831, 50 => 1014302455195967521, 99 => 1014295214413983748)
1788127727.649 sable_history  #x1B[2m2027-08-30T22:36:50.149135Z#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
1788127727.871 3 -> S: JOIN #chan
1788127727.872 sable_ircd     #x1B[2m2026-08-30T22:08:47.871366Z#x1B[0m #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
1788127727.872 sable_ircd     #x1B[2m2026-08-30T22:08:47.871515Z#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"JOIN #chan"
1788127727.971 3 -> S: PING synchronize374.092443719
1788127727.971 sable_ircd     #x1B[2m2026-08-30T22:08:47.971351Z#x1B[0m #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
1788127727.971 sable_ircd     #x1B[2m2026-08-30T22:08:47.971442Z#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 synchronize374.092443719"
1788127728.223 sable_ircd     #x1B[2m2026-08-30T22:08:48.223335Z#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(882024081409445896)), timestamp: 1788127728, clock: EventClock(1 => 882024076560830471), target: Membership(MembershipId(UserId(Snowflake(882024076560830469)), ChannelId(Snowflake(882024063889838082)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024063889838082)), user: UserId(Snowflake(882024076560830469)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882024076560830471) my clock=EventClock(1 => 882024076560830471)
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223504Z#x1B[0m #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
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223572Z#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
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223789Z#x1B[0m #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(882024081409445896)), timestamp: 1788127728, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024076560830469)), ChannelId(Snowflake(882024063889838082))), user: HistoricUserId(UserId(Snowflake(882024076560830469)), 2) }), users_to_notify: [UserId(Snowflake(882024068541321219)), UserId(Snowflake(882024076560830469)), UserId(Snowflake(882024060521811968))] })
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223820Z#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(882024081409445896)), timestamp: 1788127728, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024076560830469)), ChannelId(Snowflake(882024063889838082))), user: HistoricUserId(UserId(Snowflake(882024076560830469)), 2) }), users_to_notify: [UserId(Snowflake(882024068541321219)), UserId(Snowflake(882024076560830469)), UserId(Snowflake(882024060521811968))] }
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223871Z#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): :baz!username@localhost JOIN #chan
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223898Z#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): :baz!username@localhost JOIN #chan
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223927Z#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 353 baz = #chan :bar baz @foo
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223939Z#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 366 baz #chan :End of names list
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223951Z#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): :baz!username@localhost JOIN #chan
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223979Z#x1B[0m #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(882024081409445896)), timestamp: 1788127728, change: EventComplete(EventComplete), users_to_notify: [] })
1788127728.224 sable_ircd     #x1B[2m2026-08-30T22:08:48.223991Z#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(882024081409445896)), timestamp: 1788127728, change: EventComplete(EventComplete), users_to_notify: [] }
1788127728.224 S -> 3: :baz!username@localhost JOIN #chan
1788127728.224 S -> 3: :My.Little.Server 353 baz = #chan :bar baz @foo
1788127728.224 S -> 3: :My.Little.Server 366 baz #chan :End of names list
1788127728.509 sable_history  #x1B[2m2027-08-30T22:50:51.009569Z#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(1014306233680863281)), timestamp: 1819666251, clock: EventClock(1 => 1014295401760559126, 50 => 1014305982022623280, 99 => 1014295404927660036), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666251 }) }; event clock=EventClock(1 => 1014295401760559126, 50 => 1014305982022623280, 99 => 1014295404927660036) my clock=EventClock(1 => 1014295401760559126, 50 => 1014305982022623280, 99 => 1014295404927660036)
1788127728.509 sable_history  #x1B[2m2027-08-30T22:50:51.011238Z#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
1788127728.899 sable_history  #x1B[2m2027-08-30T22:40:35.382896Z#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(1014303651558268966)), timestamp: 1819665635, clock: EventClock(1 => 1014295842380582945, 50 => 1014303399900028965, 99 => 1014295842997547013), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665635 }) }; event clock=EventClock(1 => 1014295842380582945, 50 => 1014303399900028965, 99 => 1014295842997547013) my clock=EventClock(1 => 1014295842380582945, 50 => 1014303399900028965, 99 => 1014295842997547013)
1788127728.899 sable_history  #x1B[2m2027-08-30T22:40:35.384405Z#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
1788127729.126 sable_history  #x1B[2m2027-08-30T22:53:40.339968Z#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(1014306943906553908)), timestamp: 1819666420, clock: EventClock(1 => 1014295353727389718, 50 => 1014306692244119603, 99 => 1014295356898684932), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666420 }) }; event clock=EventClock(1 => 1014295353727389718, 50 => 1014306692244119603, 99 => 1014295356898684932) my clock=EventClock(1 => 1014295353727389718, 50 => 1014306692244119603, 99 => 1014295356898684932)
1788127729.126 sable_history  #x1B[2m2027-08-30T22:53:40.341393Z#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
1788127729.137 sable_history  #x1B[2m2027-08-30T22:37:47.716852Z#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(1014302948316094498)), timestamp: 1819665467, clock: EventClock(1 => 1014295135892017153, 50 => 1014302696653660193), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665467 }) }; event clock=EventClock(1 => 1014295135892017153, 50 => 1014302696653660193) my clock=EventClock(1 => 1014295135892017153, 50 => 1014302696653660193)
1788127729.137 sable_history  #x1B[2m2027-08-30T22:37:47.718117Z#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
1788127729.225 3: waiting…
1788127729.228 sable_ircd     #x1B[2m2026-08-30T22:08:49.228396Z#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 :synchronize374.092443719
1788127729.229 S -> 3: :My.Little.Server PONG My.Little.Server :synchronize374.092443719
1788127729.229 4: connects to server.
1788127729.229 4 -> S: NICK qux
1788127729.229 4 -> S: USER username * * :Realname
1788127729.229 sable_ircd     #x1B[2m2026-08-30T22:08:49.229107Z#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), 5), remote_addr: 127.0.0.1, tls_info: None }
1788127729.229 sable_ircd     #x1B[2m2026-08-30T22:08:49.229190Z#x1B[0m #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
1788127729.229 sable_ircd     #x1B[2m2026-08-30T22:08:49.229219Z#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), 5)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection
1788127729.229 sable_ircd     #x1B[2m2026-08-30T22:08:49.229262Z#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), 5)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 5): :My.Little.Server NOTICE * :*** Looking up your hostname
1788127729.229 sable_ircd     #x1B[2m2026-08-30T22:08:49.229376Z#x1B[0m #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
1788127729.230 S -> 4: :My.Little.Server NOTICE * :*** Looking up your hostname
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.229427Z#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), 5)#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 qux"
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.229524Z#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: 375, tv_nsec: 350870004 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("qux")), 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
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.229559Z#x1B[0m #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
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.229572Z#x1B[0m #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
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.229588Z#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), 5)#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"
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.229624Z#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: 375, tv_nsec: 350870004 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("qux")), 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
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.230088Z#x1B[0m #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
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.230120Z#x1B[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), 5): 127.0.0.1/Some(Hostname("localhost"))
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.230144Z#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), 5): :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.230167Z#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: 375, tv_nsec: 350870004 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("qux")), 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
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.230206Z#x1B[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), 5))
1788127729.230 sable_ircd     #x1B[2m2026-08-30T22:08:49.230404Z#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(882024085633110025)), timestamp: 1788127729, clock: EventClock(1 => 882024081409445896), target: User(UserId(Snowflake(882024085633110023))), details: NewUser(NewUser { nickname: Nickname("qux"), 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(882024085633110024)), NewUserConnection { user: UserId(Snowflake(882024085633110023)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1788127729 })) }) }; event clock=EventClock(1 => 882024081409445896) my clock=EventClock(1 => 882024081409445896)
1788127729.230 S -> 4: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230481Z#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
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230683Z#x1B[0m #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(882024085633110025)), timestamp: 1788127729, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024085633110023)), 1) }), users_to_notify: [] })
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230710Z#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(882024085633110025)), timestamp: 1788127729, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(882024085633110023)), 1) }), users_to_notify: [] }
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230746Z#x1B[0m #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(882024085633110025)), timestamp: 1788127729, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024085633110023)), 2), connection: UserConnectionId(Snowflake(882024085633110024)) }), users_to_notify: [] })
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230760Z#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(882024085633110025)), timestamp: 1788127729, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(882024085633110023)), 2), connection: UserConnectionId(Snowflake(882024085633110024)) }), users_to_notify: [] }
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230794Z#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), 5): :My.Little.Server 001 qux :Welcome to the test Internet Relay Chat network, qux
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230809Z#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), 5): :My.Little.Server 002 qux :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230824Z#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), 5): :My.Little.Server 003 qux :This server was created 2026-08-30 22:08:49.230818095 UTC
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230835Z#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), 5): :My.Little.Server 004 qux My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230850Z#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), 5): :My.Little.Server 005 qux 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
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230861Z#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), 5): :My.Little.Server 422 qux :MOTD File is missing
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230877Z#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), 5): :qux!username@localhost MODE qux +
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230887Z#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), 5): :My.Little.Server NOTICE qux :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230902Z#x1B[0m #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(882024085633110025)), timestamp: 1788127729, change: EventComplete(EventComplete), users_to_notify: [] })
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.230913Z#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(882024085633110025)), timestamp: 1788127729, change: EventComplete(EventComplete), users_to_notify: [] }
1788127729.231 S -> 4: :My.Little.Server 001 qux :Welcome to the test Internet Relay Chat network, qux
1788127729.231 4 -> S: PING foo
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.231270Z#x1B[0m #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
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.231306Z#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), 5)#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"
1788127729.231 sable_ircd     #x1B[2m2026-08-30T22:08:49.231373Z#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), 5): :My.Little.Server PONG My.Little.Server :foo
1788127729.331 4 -> S: PING synchronize375.452853733
1788127729.331 S -> 4: :My.Little.Server 002 qux :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1788127729.331 S -> 4: :My.Little.Server 003 qux :This server was created 2026-08-30 22:08:49.230818095 UTC
1788127729.331 S -> 4: :My.Little.Server 004 qux My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1788127729.331 S -> 4: :My.Little.Server 005 qux 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
1788127729.331 S -> 4: :My.Little.Server 422 qux :MOTD File is missing
1788127729.331 S -> 4: :qux!username@localhost MODE qux +
1788127729.331 S -> 4: :My.Little.Server NOTICE qux :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1788127729.331 S -> 4: :My.Little.Server PONG My.Little.Server :foo
1788127729.332 sable_ircd     #x1B[2m2026-08-30T22:08:49.331625Z#x1B[0m #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
1788127729.332 sable_ircd     #x1B[2m2026-08-30T22:08:49.331673Z#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), 5)#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 synchronize375.452853733"
1788127729.332 sable_ircd     #x1B[2m2026-08-30T22:08:49.331787Z#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), 5): :My.Little.Server PONG My.Little.Server :synchronize375.452853733
1788127729.332 S -> 4: :My.Little.Server PONG My.Little.Server :synchronize375.452853733
1788127729.637 sable_history  #x1B[2m2027-08-30T22:56:46.047658Z#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(1014307722818166839)), timestamp: 1819666606, clock: EventClock(1 => 1014295552021499922, 50 => 1014307471159926838, 99 => 1014295555868078086), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819666606 }) }; event clock=EventClock(1 => 1014295552021499922, 50 => 1014307471159926838, 99 => 1014295555868078086) my clock=EventClock(1 => 1014295552021499922, 50 => 1014307471159926838, 99 => 1014295555868078086)
1788127729.637 sable_history  #x1B[2m2027-08-30T22:56:46.049107Z#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
1788127729.755 sable_history  #x1B[2m2027-08-30T22:37:48.190621Z#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(1014302950300000290)), timestamp: 1819665468, clock: EventClock(1 => 1014295138538622977, 50 => 1014302698650148897), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665468 }) }; event clock=EventClock(1 => 1014295138538622977, 50 => 1014302698650148897) my clock=EventClock(1 => 1014295138538622977, 50 => 1014302698650148897)
1788127729.756 sable_history  #x1B[2m2027-08-30T22:37:48.192407Z#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
1788127729.964 sable_history  #x1B[2m2027-08-30T22:43:24.671329Z#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(1014304361603604521)), timestamp: 1819665804, clock: EventClock(1 => 1014295541992919062, 50 => 1014304109945364520, 99 => 1014295545160019972), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665804 }) }; event clock=EventClock(1 => 1014295541992919062, 50 => 1014304109945364520, 99 => 1014295545160019972) my clock=EventClock(1 => 1014295541992919062, 50 => 1014304109945364520, 99 => 1014295545160019972)
1788127729.964 sable_history  #x1B[2m2027-08-30T22:43:24.672749Z#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
1788127730.033 4 -> S: JOIN #chan
1788127730.033 sable_ircd     #x1B[2m2026-08-30T22:08:50.033368Z#x1B[0m #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
1788127730.033 sable_ircd     #x1B[2m2026-08-30T22:08:50.033453Z#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), 5)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"JOIN #chan"
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.033760Z#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(882024089001136138)), timestamp: 1788127730, clock: EventClock(1 => 882024085633110025), target: Membership(MembershipId(UserId(Snowflake(882024085633110023)), ChannelId(Snowflake(882024063889838082)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(882024063889838082)), user: UserId(Snowflake(882024085633110023)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 882024085633110025) my clock=EventClock(1 => 882024085633110025)
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.033898Z#x1B[0m #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
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.033916Z#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
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034103Z#x1B[0m #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(882024089001136138)), timestamp: 1788127730, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024085633110023)), ChannelId(Snowflake(882024063889838082))), user: HistoricUserId(UserId(Snowflake(882024085633110023)), 2) }), users_to_notify: [UserId(Snowflake(882024060521811968)), UserId(Snowflake(882024068541321219)), UserId(Snowflake(882024085633110023)), UserId(Snowflake(882024076560830469))] })
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034133Z#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(882024089001136138)), timestamp: 1788127730, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(882024085633110023)), ChannelId(Snowflake(882024063889838082))), user: HistoricUserId(UserId(Snowflake(882024085633110023)), 2) }), users_to_notify: [UserId(Snowflake(882024060521811968)), UserId(Snowflake(882024068541321219)), UserId(Snowflake(882024085633110023)), UserId(Snowflake(882024076560830469))] }
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034185Z#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): :qux!username@localhost JOIN #chan
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034207Z#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): :qux!username@localhost JOIN #chan
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034222Z#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), 5): :qux!username@localhost JOIN #chan
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034249Z#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), 5): :My.Little.Server 353 qux = #chan :@foo bar qux baz
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034261Z#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), 5): :My.Little.Server 366 qux #chan :End of names list
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034273Z#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): :qux!username@localhost JOIN #chan
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034305Z#x1B[0m #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(882024089001136138)), timestamp: 1788127730, change: EventComplete(EventComplete), users_to_notify: [] })
1788127730.034 sable_ircd     #x1B[2m2026-08-30T22:08:50.034317Z#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(882024089001136138)), timestamp: 1788127730, change: EventComplete(EventComplete), users_to_notify: [] }
1788127730.133 4 -> S: PING synchronize376.254596124
1788127730.133 S -> 4: :qux!username@localhost JOIN #chan
1788127730.133 S -> 4: :My.Little.Server 353 qux = #chan :@foo bar qux baz
1788127730.133 S -> 4: :My.Little.Server 366 qux #chan :End of names list
1788127730.133 sable_ircd     #x1B[2m2026-08-30T22:08:50.133370Z#x1B[0m #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
1788127730.133 sable_ircd     #x1B[2m2026-08-30T22:08:50.133438Z#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), 5)#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 synchronize376.254596124"
1788127730.313 sable_history  #x1B[2m2027-08-30T22:37:48.941719Z#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(1014302953454116898)), timestamp: 1819665468, clock: EventClock(1 => 1014295140782575617, 50 => 1014302701795876897), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665468 }) }; event clock=EventClock(1 => 1014295140782575617, 50 => 1014302701795876897) my clock=EventClock(1 => 1014295140782575617, 50 => 1014302701795876897)
1788127730.313 sable_history  #x1B[2m2027-08-30T22:37:48.943308Z#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
1788127730.700 sable_history  #x1B[2m2027-08-30T22:46:14.293885Z#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(1014305073054031916)), timestamp: 1819665974, clock: EventClock(1 => 1014295494442094614, 50 => 1014304821395791915, 99 => 1014295497634361348), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665974 }) }; event clock=EventClock(1 => 1014295494442094614, 50 => 1014304821395791915, 99 => 1014295497634361348) my clock=EventClock(1 => 1014295494442094614, 50 => 1014304821395791915, 99 => 1014295497634361348)
1788127730.700 sable_history  #x1B[2m2027-08-30T22:46:14.295448Z#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
1788127730.746 sable_history  #x1B[2m2027-08-30T22:37:49.167752Z#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(1014302954402029602)), timestamp: 1819665469, clock: EventClock(1 => 1014295142766481409, 50 => 1014302702743789601), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665469 }) }; event clock=EventClock(1 => 1014295142766481409, 50 => 1014302702743789601) my clock=EventClock(1 => 1014295142766481409, 50 => 1014302702743789601)
1788127730.746 sable_history  #x1B[2m2027-08-30T22:37:49.169279Z#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
1788127731.128 sable_history  #x1B[2m2027-08-30T22:37:49.547571Z#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(1014302955991670818)), timestamp: 1819665469, clock: EventClock(1 => 1014295144268042241, 50 => 1014302704337625121), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1819665469 }) }; event clock=EventClock(1 => 1014295144268042241, 50 => 1014302704337625121) my clock=EventClock(1 => 1014295144268042241, 50 => 1014302704337625121)
1788127731.128 sable_history  #x1B[2m2027-08-30T22:37:49.549387Z#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
1788127731.134 4: waiting…
1788127731.138 sable_ircd     #x1B[2m2026-08-30T22:08:51.137696Z#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), 5): :My.Little.Server PONG My.Little.Server :synchronize376.254596124
1788127731.138 S -> 4: :My.Little.Server PONG My.Little.Server :synchronize376.254596124
1788127731.141 1: disconnects from server.
1788127731.141 2: disconnects from server.
1788127731.141 3: disconnects from server.
1788127731.141 4: disconnects from server.