--------------------------------- Captured Out ---------------------------------
---- new test ----
1786476516.038 sable_ircd     uid=1001
1786476516.041 sable_ircd     #x1B[2m2026-08-11T19:28:36.041069Z#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(875098395549634560)), timestamp: 1786476516, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476516, name: ServerName("My.Little.Server"), ts: 1786476516, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1786476516.041 sable_ircd     #x1B[2m2026-08-11T19:28:36.041166Z#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
1786476516.041 sable_ircd     #x1B[2m2026-08-11T19:28:36.041314Z#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(875098395549634560)), timestamp: 1786476516, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476516, name: ServerName("My.Little.Server"), ts: 1786476516, 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
1786476516.042 sable_ircd     #x1B[2m2026-08-11T19:28:36.041931Z#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(875098395549634561)), timestamp: 1786476516, clock: EventClock(1 => 875098395549634560), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1786476516 }) }; event clock=EventClock(1 => 875098395549634560) my clock=EventClock(1 => 875098395549634560)
1786476516.042 sable_ircd     #x1B[2m2026-08-11T19:28:36.042002Z#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
1786476516.042 sable_ircd     #x1B[2m2026-08-11T19:28:36.042319Z#x1B[0m #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(875098395549634560)), timestamp: 1786476516, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1786476516.042 sable_ircd     #x1B[2m2026-08-11T19:28:36.042370Z#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(875098395549634560)), timestamp: 1786476516, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1786476516.042 sable_ircd     #x1B[2m2026-08-11T19:28:36.042441Z#x1B[0m #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
1786476516.043 sable_ircd     #x1B[2m2026-08-11T19:28:36.042535Z#x1B[0m #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(875098395549634560)), timestamp: 1786476516, change: EventComplete(EventComplete), users_to_notify: [] })
1786476516.043 sable_ircd     #x1B[2m2026-08-11T19:28:36.042578Z#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(875098395549634560)), timestamp: 1786476516, change: EventComplete(EventComplete), users_to_notify: [] }
1786476516.043 sable_ircd     #x1B[2m2026-08-11T19:28:36.042627Z#x1B[0m #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(875098395549634561)), timestamp: 1786476516, change: EventComplete(EventComplete), users_to_notify: [] })
1786476516.043 sable_ircd     #x1B[2m2026-08-11T19:28:36.042644Z#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(875098395549634561)), timestamp: 1786476516, change: EventComplete(EventComplete), users_to_notify: [] }
1786476516.060 sable_history  #x1B[2m2027-08-11T20:05:02.836007Z#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(1007379138572656682)), timestamp: 1818014702, clock: EventClock(1 => 1007369312341594113, 50 => 1007378886910222377), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014702 }) }; event clock=EventClock(1 => 1007369312341594113, 50 => 1007378886910222377) my clock=EventClock(1 => 1007369312341594113, 50 => 1007378886910222377)
1786476516.060 sable_history  #x1B[2m2027-08-11T20:05:02.837989Z#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
1786476516.134 sable_ircd     #x1B[2m2026-08-11T19:28:36.133701Z#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 }
1786476516.134 sable_ircd     #x1B[2m2026-08-11T19:28:36.133886Z#x1B[0m #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
1786476516.134 sable_ircd     #x1B[2m2026-08-11T19:28:36.133963Z#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
1786476516.134 sable_ircd     #x1B[2m2026-08-11T19:28:36.134047Z#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
1786476516.134 sable_ircd     #x1B[2m2026-08-11T19:28:36.134224Z#x1B[0m #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
1786476516.134 sable_ircd     #x1B[2m2026-08-11T19:28:36.134297Z#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"
1786476516.135 sable_ircd     #x1B[2m2026-08-11T19:28:36.134458Z#x1B[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
1786476516.135 sable_ircd     #x1B[2m2026-08-11T19:28:36.134672Z#x1B[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))
1786476516.135 sable_ircd     #x1B[2m2026-08-11T19:28:36.134726Z#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)
1786476516.136 sable_ircd     #x1B[2m2026-08-11T19:28:36.135597Z#x1B[0m #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
1786476516.136 sable_ircd     #x1B[2m2026-08-11T19:28:36.135755Z#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
1786476516.136 sable_ircd     #x1B[2m2026-08-11T19:28:36.135833Z#x1B[0m #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
1786476516.155 1: connects to server.
1786476516.155 1 -> S: NICK nick
1786476516.155 1 -> S: USER username * * :Realname
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.155493Z#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 }
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.155680Z#x1B[0m #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
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.155720Z#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
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.155789Z#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
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.155925Z#x1B[0m #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
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.155977Z#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 nick"
1786476516.156 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.156200Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 293, tv_nsec: 216263953 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("nick")), 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
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.156272Z#x1B[0m #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
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.156310Z#x1B[0m #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
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.156342Z#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"
1786476516.156 sable_ircd     #x1B[2m2026-08-11T19:28:36.156411Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 293, tv_nsec: 216263953 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick")), 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
1786476516.157 sable_ircd     #x1B[2m2026-08-11T19:28:36.157005Z#x1B[0m #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
1786476516.157 sable_ircd     #x1B[2m2026-08-11T19:28:36.157046Z#x1B[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"))
1786476516.157 sable_ircd     #x1B[2m2026-08-11T19:28:36.157071Z#x1B[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
1786476516.157 sable_ircd     #x1B[2m2026-08-11T19:28:36.157096Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 293, tv_nsec: 216263953 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick")), 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
1786476516.157 sable_ircd     #x1B[2m2026-08-11T19:28:36.157144Z#x1B[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))
1786476516.158 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.157412Z#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(875098396036173826)), timestamp: 1786476516, clock: EventClock(1 => 875098395549634561), target: User(UserId(Snowflake(875098396036173824))), details: NewUser(NewUser { nickname: Nickname("nick"), 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(875098396036173825)), NewUserConnection { user: UserId(Snowflake(875098396036173824)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1786476516 })) }) }; event clock=EventClock(1 => 875098395549634561) my clock=EventClock(1 => 875098395549634561)

1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.157551Z#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
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.157861Z#x1B[0m #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(875098396036173826)), timestamp: 1786476516, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098396036173824)), 1) }), users_to_notify: [] })
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.157895Z#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(875098396036173826)), timestamp: 1786476516, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098396036173824)), 1) }), users_to_notify: [] }
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.157940Z#x1B[0m #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(875098396036173826)), timestamp: 1786476516, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098396036173824)), 2), connection: UserConnectionId(Snowflake(875098396036173825)) }), users_to_notify: [] })
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.157963Z#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(875098396036173826)), timestamp: 1786476516, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098396036173824)), 2), connection: UserConnectionId(Snowflake(875098396036173825)) }), users_to_notify: [] }
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158014Z#x1B[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 nick :Welcome to the test Internet Relay Chat network, nick
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158041Z#x1B[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 nick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158065Z#x1B[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 nick :This server was created 2026-08-11 19:28:36.158055670 UTC
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158082Z#x1B[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 nick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158114Z#x1B[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 nick 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
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158133Z#x1B[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 nick :MOTD File is missing
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158152Z#x1B[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): :nick!username@localhost MODE nick +
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158168Z#x1B[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 nick :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158212Z#x1B[0m #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(875098396036173826)), timestamp: 1786476516, change: EventComplete(EventComplete), users_to_notify: [] })
1786476516.158 sable_ircd     #x1B[2m2026-08-11T19:28:36.158236Z#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(875098396036173826)), timestamp: 1786476516, change: EventComplete(EventComplete), users_to_notify: [] }
1786476516.158 S -> 1: :My.Little.Server 001 nick :Welcome to the test Internet Relay Chat network, nick
1786476516.159 1 -> S: PING foo
1786476516.159 sable_ircd     #x1B[2m2026-08-11T19:28:36.158790Z#x1B[0m #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
1786476516.159 sable_ircd     #x1B[2m2026-08-11T19:28:36.158843Z#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"
1786476516.159 sable_ircd     #x1B[2m2026-08-11T19:28:36.158944Z#x1B[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
1786476516.259 1 -> S: PING synchronize293.319199921
1786476516.259 S -> 1: :My.Little.Server 002 nick :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476516.259 S -> 1: :My.Little.Server 003 nick :This server was created 2026-08-11 19:28:36.158055670 UTC
1786476516.259 S -> 1: :My.Little.Server 004 nick My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476516.259 S -> 1: :My.Little.Server 005 nick 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
1786476516.259 S -> 1: :My.Little.Server 422 nick :MOTD File is missing
1786476516.259 S -> 1: :nick!username@localhost MODE nick +
1786476516.259 S -> 1: :My.Little.Server NOTICE nick :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476516.259 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1786476516.260 sable_ircd     #x1B[2m2026-08-11T19:28:36.259421Z#x1B[0m #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
1786476516.260 sable_ircd     #x1B[2m2026-08-11T19:28:36.259540Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize293.319199921"
1786476516.260 sable_ircd     #x1B[2m2026-08-11T19:28:36.259717Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :synchronize293.319199921
1786476516.260 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize293.319199921
1786476516.560 sable_history  #x1B[2m2027-08-11T20:05:03.443412Z#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(1007379141118599210)), timestamp: 1818014703, clock: EventClock(1 => 1007369314333888513, 50 => 1007378889464553513), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014703 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007378889464553513) my clock=EventClock(1 => 1007369314333888513, 50 => 1007378889464553513)
1786476516.561 sable_history  #x1B[2m2027-08-11T20:05:03.446003Z#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
1786476516.876 sable_history  #x1B[2m2027-08-11T20:10:39.717553Z#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(1007380551553982513)), timestamp: 1818015039, clock: EventClock(1 => 1007369718299889686, 50 => 1007380299899936816, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015039 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007380299899936816, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007380299899936816, 99 => 1007369721508933636)
1786476516.876 sable_history  #x1B[2m2027-08-11T20:10:39.719177Z#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
1786476516.961 1 -> S: HELP THISISNOTACOMMAND
1786476516.962 sable_ircd     #x1B[2m2026-08-11T19:28:36.961899Z#x1B[0m #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
1786476516.962 sable_ircd     #x1B[2m2026-08-11T19:28:36.961986Z#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"HELP THISISNOTACOMMAND"
1786476517.043 sable_history  #x1B[2m2027-08-11T20:05:03.850342Z#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(1007379142825680938)), timestamp: 1818014703, clock: EventClock(1 => 1007369316242296833, 50 => 1007378891003863081), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014703 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007378891003863081) my clock=EventClock(1 => 1007369316242296833, 50 => 1007378891003863081)
1786476517.044 sable_history  #x1B[2m2027-08-11T20:05:03.852527Z#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
1786476517.062 1 -> S: PING synchronize294.121921411
1786476517.062 sable_ircd     #x1B[2m2026-08-11T19:28:37.062192Z#x1B[0m #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
1786476517.062 sable_ircd     #x1B[2m2026-08-11T19:28:37.062272Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize294.121921411"
1786476517.062 sable_ircd     #x1B[2m2026-08-11T19:28:37.062446Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 421 nick HELP :Unknown command
1786476517.063 S -> 1: :My.Little.Server 421 nick HELP :Unknown command
1786476517.536 sable_history  #x1B[2m2027-08-11T20:13:28.355801Z#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(1007381258877214772)), timestamp: 1818015208, clock: EventClock(1 => 1007369670753259542, 50 => 1007381007214780467, 99 => 1007369673970692100), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015208 }) }; event clock=EventClock(1 => 1007369670753259542, 50 => 1007381007214780467, 99 => 1007369673970692100) my clock=EventClock(1 => 1007369670753259542, 50 => 1007381007214780467, 99 => 1007369673970692100)
1786476517.536 sable_history  #x1B[2m2027-08-11T20:13:28.357450Z#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
1786476517.550 sable_history  #x1B[2m2027-08-11T20:05:04.566863Z#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(1007379145832996906)), timestamp: 1818014704, clock: EventClock(1 => 1007369318356226049, 50 => 1007378894170562601), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014704 }) }; event clock=EventClock(1 => 1007369318356226049, 50 => 1007378894170562601) my clock=EventClock(1 => 1007369318356226049, 50 => 1007378894170562601)
1786476517.550 sable_history  #x1B[2m2027-08-11T20:05:04.569301Z#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
1786476518.059 sable_history  #x1B[2m2027-08-11T20:05:05.943811Z#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(1007379151608553515)), timestamp: 1818014705, clock: EventClock(1 => 1007369320184942593, 50 => 1007378899933536298, 99 => 1007369323750502402), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014705 }) }; event clock=EventClock(1 => 1007369320184942593, 50 => 1007378899933536298, 99 => 1007369323750502402) my clock=EventClock(1 => 1007369320184942593, 50 => 1007378899933536298, 99 => 1007369323750502402)
1786476518.059 sable_history  #x1B[2m2027-08-11T20:05:05.945970Z#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
1786476518.064 1: waiting…
1786476518.068 sable_ircd     #x1B[2m2026-08-11T19:28:38.068232Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :synchronize294.121921411
1786476518.069 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize294.121921411
1786476518.072 1: disconnects from server.