--------------------------------- Captured Out ---------------------------------
---- new test ----
1786476520.128 sable_ircd     uid=1001
1786476520.132 sable_ircd     #x1B[2m2026-08-11T19:28:40.132303Z#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(875098412708532224)), timestamp: 1786476520, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476520, name: ServerName("My.Little.Server"), ts: 1786476520, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1786476520.132 sable_ircd     #x1B[2m2026-08-11T19:28:40.132424Z#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
1786476520.133 sable_ircd     #x1B[2m2026-08-11T19:28:40.132781Z#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(875098412708532224)), timestamp: 1786476520, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1786476520, name: ServerName("My.Little.Server"), ts: 1786476520, 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
1786476520.133 sable_ircd     #x1B[2m2026-08-11T19:28:40.132958Z#x1B[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(875098412708532224)), timestamp: 1786476520, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1786476520.133 sable_ircd     #x1B[2m2026-08-11T19:28:40.132994Z#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(875098412708532224)), timestamp: 1786476520, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1786476520.133 sable_ircd     #x1B[2m2026-08-11T19:28:40.133042Z#x1B[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(875098412708532224)), timestamp: 1786476520, change: EventComplete(EventComplete), users_to_notify: [] })
1786476520.133 sable_ircd     #x1B[2m2026-08-11T19:28:40.133068Z#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(875098412708532224)), timestamp: 1786476520, change: EventComplete(EventComplete), users_to_notify: [] }
1786476520.133 sable_ircd     #x1B[2m2026-08-11T19:28:40.133323Z#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(875098412712726529)), timestamp: 1786476520, clock: EventClock(1 => 875098412708532224), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1786476520 }) }; event clock=EventClock(1 => 875098412708532224) my clock=EventClock(1 => 875098412708532224)
1786476520.133 sable_ircd     #x1B[2m2026-08-11T19:28:40.133373Z#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
1786476520.134 sable_ircd     #x1B[2m2026-08-11T19:28:40.133638Z#x1B[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(875098412712726529)), timestamp: 1786476520, change: EventComplete(EventComplete), users_to_notify: [] })
1786476520.134 sable_ircd     #x1B[2m2026-08-11T19:28:40.133670Z#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(875098412712726529)), timestamp: 1786476520, change: EventComplete(EventComplete), users_to_notify: [] }
1786476520.135 sable_ircd     #x1B[2m2026-08-11T19:28:40.134690Z#x1B[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
1786476520.224 sable_ircd     #x1B[2m2026-08-11T19:28:40.223578Z#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 }
1786476520.224 sable_ircd     #x1B[2m2026-08-11T19:28:40.223739Z#x1B[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
1786476520.224 sable_ircd     #x1B[2m2026-08-11T19:28:40.223799Z#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
1786476520.224 sable_ircd     #x1B[2m2026-08-11T19:28:40.223883Z#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
1786476520.224 sable_ircd     #x1B[2m2026-08-11T19:28:40.224056Z#x1B[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
1786476520.224 sable_ircd     #x1B[2m2026-08-11T19:28:40.224130Z#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"
1786476520.224 sable_ircd     #x1B[2m2026-08-11T19:28:40.224263Z#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
1786476520.224 sable_ircd     #x1B[2m2026-08-11T19:28:40.224370Z#x1B[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))
1786476520.224 sable_ircd     #x1B[2m2026-08-11T19:28:40.224410Z#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)
1786476520.225 sable_ircd     #x1B[2m2026-08-11T19:28:40.224861Z#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
1786476520.225 sable_ircd     #x1B[2m2026-08-11T19:28:40.224958Z#x1B[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
1786476520.225 sable_ircd     #x1B[2m2026-08-11T19:28:40.225186Z#x1B[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
1786476520.245 1: connects to server.
1786476520.245 1 -> S: NICK foo
1786476520.245 1 -> S: USER username * * :Realname
1786476520.245 sable_ircd     #x1B[2m2026-08-11T19:28:40.244889Z#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 }
1786476520.245 sable_ircd     #x1B[2m2026-08-11T19:28:40.245003Z#x1B[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
1786476520.245 sable_ircd     #x1B[2m2026-08-11T19:28:40.245046Z#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
1786476520.245 sable_ircd     #x1B[2m2026-08-11T19:28:40.245087Z#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
1786476520.245 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.245295Z#x1B[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
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.245384Z#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"
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.245586Z#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: 297, tv_nsec: 305576489 }, 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
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.245672Z#x1B[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
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.245722Z#x1B[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
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.245771Z#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"
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.245861Z#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: 297, tv_nsec: 305576489 }, 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
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.245955Z#x1B[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
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.245998Z#x1B[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"))
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.246044Z#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
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.246084Z#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: 297, tv_nsec: 305576489 }, 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
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.246146Z#x1B[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))
1786476520.246 sable_ircd     #x1B[2m2026-08-11T19:28:40.246384Z#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(875098413186682882)), timestamp: 1786476520, clock: EventClock(1 => 875098412712726529), target: User(UserId(Snowflake(875098413186682880))), 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(875098413186682881)), NewUserConnection { user: UserId(Snowflake(875098413186682880)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1786476520 })) }) }; event clock=EventClock(1 => 875098412712726529) my clock=EventClock(1 => 875098412712726529)
1786476520.247 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.246498Z#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
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.246783Z#x1B[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(875098413186682882)), timestamp: 1786476520, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098413186682880)), 1) }), users_to_notify: [] })
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.246828Z#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(875098413186682882)), timestamp: 1786476520, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098413186682880)), 1) }), users_to_notify: [] }
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.246891Z#x1B[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(875098413186682882)), timestamp: 1786476520, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098413186682880)), 2), connection: UserConnectionId(Snowflake(875098413186682881)) }), users_to_notify: [] })
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.246924Z#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(875098413186682882)), timestamp: 1786476520, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098413186682880)), 2), connection: UserConnectionId(Snowflake(875098413186682881)) }), users_to_notify: [] }
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.246986Z#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
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.247027Z#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
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.247074Z#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-11 19:28:40.247057270 UTC
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.247112Z#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
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.247168Z#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
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.247214Z#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
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.247258Z#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 +
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.247295Z#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.
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.247338Z#x1B[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(875098413186682882)), timestamp: 1786476520, change: EventComplete(EventComplete), users_to_notify: [] })
1786476520.247 sable_ircd     #x1B[2m2026-08-11T19:28:40.247370Z#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(875098413186682882)), timestamp: 1786476520, change: EventComplete(EventComplete), users_to_notify: [] }
1786476520.248 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo
1786476520.248 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476520.248 S -> 1: :My.Little.Server 003 foo :This server was created 2026-08-11 19:28:40.247057270 UTC
1786476520.248 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476520.248 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
1786476520.248 S -> 1: :My.Little.Server 422 foo :MOTD File is missing
1786476520.248 S -> 1: :foo!username@localhost MODE foo +
1786476520.248 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476520.248 1 -> S: PING foo
1786476520.248 sable_ircd     #x1B[2m2026-08-11T19:28:40.248367Z#x1B[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
1786476520.248 sable_ircd     #x1B[2m2026-08-11T19:28:40.248418Z#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"
1786476520.249 sable_ircd     #x1B[2m2026-08-11T19:28:40.248526Z#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
1786476520.560 sable_history  #x1B[2m2027-08-11T20:06:03.444590Z#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(1007379392781033515)), timestamp: 1818014763, clock: EventClock(1 => 1007369314333888513, 50 => 1007379141118599210), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014763 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007379141118599210) my clock=EventClock(1 => 1007369314333888513, 50 => 1007379141118599210)
1786476520.561 sable_history  #x1B[2m2027-08-11T20:06:03.446463Z#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
1786476520.876 sable_history  #x1B[2m2027-08-11T20:11:39.717737Z#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(1007380803212222514)), timestamp: 1818015099, clock: EventClock(1 => 1007369718299889686, 50 => 1007380551553982513, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015099 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007380551553982513, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007380551553982513, 99 => 1007369721508933636)
1786476520.876 sable_history  #x1B[2m2027-08-11T20:11:39.719562Z#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
1786476521.041 sable_history  #x1B[2m2027-08-11T20:06:03.811029Z#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(1007379394320343083)), timestamp: 1818014763, clock: EventClock(1 => 1007369316242296833, 50 => 1007379142825680938), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014763 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007379142825680938) my clock=EventClock(1 => 1007369316242296833, 50 => 1007379142825680938)
1786476521.041 sable_history  #x1B[2m2027-08-11T20:06:03.813067Z#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
1786476521.049 1 -> S: PING synchronize298.109643729
1786476521.049 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1786476521.050 sable_ircd     #x1B[2m2026-08-11T19:28:41.049775Z#x1B[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
1786476521.050 sable_ircd     #x1B[2m2026-08-11T19:28:41.049851Z#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 synchronize298.109643729"
1786476521.050 sable_ircd     #x1B[2m2026-08-11T19:28:41.050034Z#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 :synchronize298.109643729
1786476521.050 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize298.109643729
1786476521.050 1 -> S: JOIN #chan
1786476521.051 sable_ircd     #x1B[2m2026-08-11T19:28:41.050726Z#x1B[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
1786476521.051 sable_ircd     #x1B[2m2026-08-11T19:28:41.050777Z#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"
1786476521.051 sable_ircd     #x1B[2m2026-08-11T19:28:41.051037Z#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(875098416563097603)), timestamp: 1786476521, clock: EventClock(1 => 875098413186682882), target: Channel(ChannelId(Snowflake(875098416558903298))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 875098413186682882) my clock=EventClock(1 => 875098413186682882)
1786476521.051 sable_ircd     #x1B[2m2026-08-11T19:28:41.051242Z#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
1786476521.051 sable_ircd     #x1B[2m2026-08-11T19:28:41.051330Z#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(875098416563097604)), timestamp: 1786476521, clock: EventClock(1 => 875098416563097603), target: Membership(MembershipId(UserId(Snowflake(875098413186682880)), ChannelId(Snowflake(875098416558903298)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(875098416558903298)), user: UserId(Snowflake(875098413186682880)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 875098416563097603) my clock=EventClock(1 => 875098416563097603)
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.051464Z#x1B[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
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.051510Z#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
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.051606Z#x1B[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(875098416563097603)), timestamp: 1786476521, change: EventComplete(EventComplete), users_to_notify: [] })
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.051642Z#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(875098416563097603)), timestamp: 1786476521, change: EventComplete(EventComplete), users_to_notify: [] }
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.051785Z#x1B[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(875098416563097604)), timestamp: 1786476521, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(875098413186682880)), ChannelId(Snowflake(875098416558903298))), user: HistoricUserId(UserId(Snowflake(875098413186682880)), 2) }), users_to_notify: [UserId(Snowflake(875098413186682880))] })
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.051828Z#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(875098416563097604)), timestamp: 1786476521, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(875098413186682880)), ChannelId(Snowflake(875098416558903298))), user: HistoricUserId(UserId(Snowflake(875098413186682880)), 2) }), users_to_notify: [UserId(Snowflake(875098413186682880))] }
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.051903Z#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
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.051959Z#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
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.052028Z#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
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.052070Z#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
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.052132Z#x1B[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(875098416563097604)), timestamp: 1786476521, change: EventComplete(EventComplete), users_to_notify: [] })
1786476521.052 sable_ircd     #x1B[2m2026-08-11T19:28:41.052174Z#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(875098416563097604)), timestamp: 1786476521, change: EventComplete(EventComplete), users_to_notify: [] }
1786476521.151 1 -> S: PING synchronize298.211119954
1786476521.151 S -> 1: :foo!username@localhost JOIN #chan
1786476521.151 S -> 1: :foo!username@localhost MODE #chan +o foo
1786476521.151 S -> 1: :My.Little.Server 353 foo = #chan :@foo
1786476521.151 S -> 1: :My.Little.Server 366 foo #chan :End of names list
1786476521.151 sable_ircd     #x1B[2m2026-08-11T19:28:41.151160Z#x1B[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
1786476521.151 sable_ircd     #x1B[2m2026-08-11T19:28:41.151221Z#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 synchronize298.211119954"
1786476521.536 sable_history  #x1B[2m2027-08-11T20:14:28.356531Z#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(1007381510535454773)), timestamp: 1818015268, clock: EventClock(1 => 1007369670753259542, 50 => 1007381258877214772, 99 => 1007369673970692100), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015268 }) }; event clock=EventClock(1 => 1007369670753259542, 50 => 1007381258877214772, 99 => 1007369673970692100) my clock=EventClock(1 => 1007369670753259542, 50 => 1007381258877214772, 99 => 1007369673970692100)
1786476521.536 sable_history  #x1B[2m2027-08-11T20:14:28.358509Z#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
1786476521.549 sable_history  #x1B[2m2027-08-11T20:06:04.565563Z#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(1007379397487042603)), timestamp: 1818014764, clock: EventClock(1 => 1007369318356226049, 50 => 1007379145832996906), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014764 }) }; event clock=EventClock(1 => 1007369318356226049, 50 => 1007379145832996906) my clock=EventClock(1 => 1007369318356226049, 50 => 1007379145832996906)
1786476521.549 sable_history  #x1B[2m2027-08-11T20:06:04.567213Z#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
1786476522.059 sable_history  #x1B[2m2027-08-11T20:06:05.943942Z#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(1007379403266793516)), timestamp: 1818014765, clock: EventClock(1 => 1007369320184942593, 50 => 1007379151608553515, 99 => 1007369323750502402), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014765 }) }; event clock=EventClock(1 => 1007369320184942593, 50 => 1007379151608553515, 99 => 1007369323750502402) my clock=EventClock(1 => 1007369320184942593, 50 => 1007379151608553515, 99 => 1007369323750502402)
1786476522.059 sable_history  #x1B[2m2027-08-11T20:06:05.945865Z#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
1786476522.152 1: waiting…
1786476522.156 sable_ircd     #x1B[2m2026-08-11T19:28:42.155811Z#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 :synchronize298.211119954
1786476522.156 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize298.211119954
1786476522.156 1 -> S: MODE #chan +i
1786476522.157 sable_ircd     #x1B[2m2026-08-11T19:28:42.156628Z#x1B[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
1786476522.157 sable_ircd     #x1B[2m2026-08-11T19:28:42.156671Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"MODE #chan +i"
1786476522.257 1 -> S: PING synchronize299.316966884
1786476522.257 sable_ircd     #x1B[2m2026-08-11T19:28:42.256928Z#x1B[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
1786476522.257 sable_ircd     #x1B[2m2026-08-11T19:28:42.256977Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize299.316966884"
1786476522.436 sable_history  #x1B[2m2027-08-11T20:17:25.928028Z#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(1007382255326404664)), timestamp: 1818015445, clock: EventClock(1 => 1007369621558267926, 50 => 1007382003668164663, 99 => 1007369624859586564), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015445 }) }; event clock=EventClock(1 => 1007369621558267926, 50 => 1007382003668164663, 99 => 1007369624859586564) my clock=EventClock(1 => 1007369621558267926, 50 => 1007382003668164663, 99 => 1007369624859586564)
1786476522.436 sable_history  #x1B[2m2027-08-11T20:17:25.929530Z#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
1786476522.479 sable_history  #x1B[2m2027-08-11T20:06:05.418427Z#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(1007379401060589612)), timestamp: 1818014765, clock: EventClock(1 => 1007369401122426895, 50 => 1007379149406543915, 99 => 1007369391161356292), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014765 }) }; event clock=EventClock(1 => 1007369401122426895, 50 => 1007379149406543915, 99 => 1007369391161356292) my clock=EventClock(1 => 1007369401122426895, 50 => 1007379149406543915, 99 => 1007369391161356292)
1786476522.479 sable_history  #x1B[2m2027-08-11T20:06:05.420175Z#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
1786476523.011 sable_ircd     #x1B[2m2026-08-11T19:28:43.011072Z#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(875098424783933445)), timestamp: 1786476523, clock: EventClock(1 => 875098416563097604), target: Channel(ChannelId(Snowflake(875098416558903298))), details: ChannelModeChange(ChannelModeChange { changed_by: User(UserId(Snowflake(875098413186682880))), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange }) }; event clock=EventClock(1 => 875098416563097604) my clock=EventClock(1 => 875098416563097604)
1786476523.011 sable_ircd     #x1B[2m2026-08-11T19:28:43.011286Z#x1B[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
1786476523.011 sable_ircd     #x1B[2m2026-08-11T19:28:43.011311Z#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
1786476523.012 sable_ircd     #x1B[2m2026-08-11T19:28:43.011618Z#x1B[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(875098424783933445)), timestamp: 1786476523, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(875098416558903298)), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(875098413186682880)), 2)) }), users_to_notify: [UserId(Snowflake(875098413186682880))] })
1786476523.012 sable_ircd     #x1B[2m2026-08-11T19:28:43.011671Z#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(875098424783933445)), timestamp: 1786476523, change: ChannelModeChange(ChannelModeChange { channel: ChannelId(Snowflake(875098416558903298)), added: ChannelModeSet(8), removed: ChannelModeSet(0), key_change: NoChange, changed_by: User(HistoricUserId(UserId(Snowflake(875098413186682880)), 2)) }), users_to_notify: [UserId(Snowflake(875098413186682880))] }
1786476523.012 sable_ircd     #x1B[2m2026-08-11T19:28:43.011769Z#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 +i
1786476523.012 sable_ircd     #x1B[2m2026-08-11T19:28:43.011847Z#x1B[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(875098424783933445)), timestamp: 1786476523, change: EventComplete(EventComplete), users_to_notify: [] })
1786476523.012 sable_ircd     #x1B[2m2026-08-11T19:28:43.011894Z#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(875098424783933445)), timestamp: 1786476523, change: EventComplete(EventComplete), users_to_notify: [] }
1786476523.012 S -> 1: :foo!username@localhost MODE #chan +i
1786476523.864 sable_history  #x1B[2m2027-08-11T20:09:51.132306Z#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(1007380347773722672)), timestamp: 1818014991, clock: EventClock(1 => 1007370015864786977, 50 => 1007380096123871279, 99 => 1007370023867920389), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014991 }) }; event clock=EventClock(1 => 1007370015864786977, 50 => 1007380096123871279, 99 => 1007370023867920389) my clock=EventClock(1 => 1007370015864786977, 50 => 1007380096123871279, 99 => 1007370023867920389)
1786476523.864 sable_history  #x1B[2m2027-08-11T20:09:51.133933Z#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
1786476524.013 1: waiting…
1786476524.018 sable_ircd     #x1B[2m2026-08-11T19:28:44.017615Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :synchronize299.316966884
1786476524.018 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize299.316966884
1786476524.018 1 -> S: INVITE bar #chan
1786476524.019 sable_ircd     #x1B[2m2026-08-11T19:28:44.018587Z#x1B[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
1786476524.019 sable_ircd     #x1B[2m2026-08-11T19:28:44.018633Z#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"INVITE bar #chan"
1786476524.060 sable_history  #x1B[2m2027-08-11T20:07:02.835928Z#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(1007379641889136684)), timestamp: 1818014822, clock: EventClock(1 => 1007369312341594113, 50 => 1007379390230896683), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014822 }) }; event clock=EventClock(1 => 1007369312341594113, 50 => 1007379390230896683) my clock=EventClock(1 => 1007369312341594113, 50 => 1007379390230896683)
1786476524.060 sable_history  #x1B[2m2027-08-11T20:07:02.837886Z#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
1786476524.118 1 -> S: PING synchronize301.178858518
1786476524.119 sable_ircd     #x1B[2m2026-08-11T19:28:44.118853Z#x1B[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
1786476524.119 sable_ircd     #x1B[2m2026-08-11T19:28:44.118912Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize301.178858518"
1786476524.560 sable_history  #x1B[2m2027-08-11T20:07:03.442551Z#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(1007379644430884908)), timestamp: 1818014823, clock: EventClock(1 => 1007369314333888513, 50 => 1007379392781033515), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014823 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007379392781033515) my clock=EventClock(1 => 1007369314333888513, 50 => 1007379392781033515)
1786476524.560 sable_history  #x1B[2m2027-08-11T20:07:03.444519Z#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
1786476524.876 sable_history  #x1B[2m2027-08-11T20:12:39.717472Z#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(1007381054870462515)), timestamp: 1818015159, clock: EventClock(1 => 1007369718299889686, 50 => 1007380803212222514, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015159 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007380803212222514, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007380803212222514, 99 => 1007369721508933636)
1786476524.876 sable_history  #x1B[2m2027-08-11T20:12:39.719387Z#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
1786476525.041 sable_history  #x1B[2m2027-08-11T20:07:03.812623Z#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(1007379645982777388)), timestamp: 1818014823, clock: EventClock(1 => 1007369316242296833, 50 => 1007379394320343083), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014823 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007379394320343083) my clock=EventClock(1 => 1007369316242296833, 50 => 1007379394320343083)
1786476525.041 sable_history  #x1B[2m2027-08-11T20:07:03.814769Z#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
1786476525.120 1: waiting…
1786476525.125 sable_ircd     #x1B[2m2026-08-11T19:28:45.124486Z#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 401 foo bar :No such nick/channel
1786476525.125 S -> 1: :My.Little.Server 401 foo bar :No such nick/channel
1786476525.536 sable_history  #x1B[2m2027-08-11T20:15:28.355611Z#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(1007381762189500470)), timestamp: 1818015328, clock: EventClock(1 => 1007369670753259542, 50 => 1007381510535454773, 99 => 1007369673970692100), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015328 }) }; event clock=EventClock(1 => 1007369670753259542, 50 => 1007381510535454773, 99 => 1007369673970692100) my clock=EventClock(1 => 1007369670753259542, 50 => 1007381510535454773, 99 => 1007369673970692100)
1786476525.536 sable_history  #x1B[2m2027-08-11T20:15:28.357253Z#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
1786476525.549 sable_history  #x1B[2m2027-08-11T20:07:04.567063Z#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(1007379649149476908)), timestamp: 1818014824, clock: EventClock(1 => 1007369318356226049, 50 => 1007379397487042603), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014824 }) }; event clock=EventClock(1 => 1007369318356226049, 50 => 1007379397487042603) my clock=EventClock(1 => 1007369318356226049, 50 => 1007379397487042603)
1786476525.550 sable_history  #x1B[2m2027-08-11T20:07:04.568635Z#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
1786476526.059 sable_history  #x1B[2m2027-08-11T20:07:05.940301Z#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(1007379654908256301)), timestamp: 1818014825, clock: EventClock(1 => 1007369320184942593, 50 => 1007379403266793516, 99 => 1007369323750502402), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014825 }) }; event clock=EventClock(1 => 1007369320184942593, 50 => 1007379403266793516, 99 => 1007369323750502402) my clock=EventClock(1 => 1007369320184942593, 50 => 1007379403266793516, 99 => 1007369323750502402)
1786476526.059 sable_history  #x1B[2m2027-08-11T20:07:05.942334Z#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
1786476526.126 1: waiting…
1786476526.129 sable_ircd     #x1B[2m2026-08-11T19:28:46.129270Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :synchronize301.178858518
1786476526.130 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize301.178858518
1786476526.130 2: connects to server.
1786476526.130 2 -> S: NICK bar
1786476526.130 2 -> S: USER username * * :Realname
1786476526.130 sable_ircd     #x1B[2m2026-08-11T19:28:46.130426Z#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 }
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.130597Z#x1B[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
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.130654Z#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
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.130734Z#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
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.130915Z#x1B[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
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.130974Z#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"
1786476526.131 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.131127Z#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: 303, tv_nsec: 191210939 }, 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
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.131191Z#x1B[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
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.131233Z#x1B[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
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.131278Z#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"
1786476526.131 sable_ircd     #x1B[2m2026-08-11T19:28:46.131378Z#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: 303, tv_nsec: 191210939 }, 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
1786476526.132 sable_ircd     #x1B[2m2026-08-11T19:28:46.132023Z#x1B[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
1786476526.132 sable_ircd     #x1B[2m2026-08-11T19:28:46.132055Z#x1B[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"))
1786476526.132 sable_ircd     #x1B[2m2026-08-11T19:28:46.132079Z#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
1786476526.132 sable_ircd     #x1B[2m2026-08-11T19:28:46.132102Z#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: 303, tv_nsec: 191210939 }, 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
1786476526.132 sable_ircd     #x1B[2m2026-08-11T19:28:46.132144Z#x1B[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))
1786476526.132 sable_ircd     #x1B[2m2026-08-11T19:28:46.132383Z#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(875098437874356230)), timestamp: 1786476526, clock: EventClock(1 => 875098424783933445), target: User(UserId(Snowflake(875098437874356227))), 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(875098437874356228)), NewUserConnection { user: UserId(Snowflake(875098437874356227)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1786476526 })) }) }; event clock=EventClock(1 => 875098424783933445) my clock=EventClock(1 => 875098424783933445)
1786476526.133 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.132495Z#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
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.132798Z#x1B[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(875098437874356230)), timestamp: 1786476526, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098437874356227)), 1) }), users_to_notify: [] })
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.132843Z#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(875098437874356230)), timestamp: 1786476526, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(875098437874356227)), 1) }), users_to_notify: [] }
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.132903Z#x1B[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(875098437874356230)), timestamp: 1786476526, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098437874356227)), 2), connection: UserConnectionId(Snowflake(875098437874356228)) }), users_to_notify: [] })
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.132936Z#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(875098437874356230)), timestamp: 1786476526, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(875098437874356227)), 2), connection: UserConnectionId(Snowflake(875098437874356228)) }), users_to_notify: [] }
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133001Z#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
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133044Z#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
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133093Z#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-11 19:28:46.133075457 UTC
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133131Z#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
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133177Z#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
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133218Z#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
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133259Z#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 +
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133303Z#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.
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133366Z#x1B[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(875098437874356230)), timestamp: 1786476526, change: EventComplete(EventComplete), users_to_notify: [] })
1786476526.133 sable_ircd     #x1B[2m2026-08-11T19:28:46.133398Z#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(875098437874356230)), timestamp: 1786476526, change: EventComplete(EventComplete), users_to_notify: [] }
1786476526.134 S -> 2: :My.Little.Server 001 bar :Welcome to the test Internet Relay Chat network, bar
1786476526.134 2 -> S: PING foo
1786476526.134 sable_ircd     #x1B[2m2026-08-11T19:28:46.133973Z#x1B[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
1786476526.134 sable_ircd     #x1B[2m2026-08-11T19:28:46.134011Z#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"
1786476526.134 sable_ircd     #x1B[2m2026-08-11T19:28:46.134079Z#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
1786476526.234 2 -> S: PING synchronize303.294358521
1786476526.234 S -> 2: :My.Little.Server 002 bar :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1786476526.234 S -> 2: :My.Little.Server 003 bar :This server was created 2026-08-11 19:28:46.133075457 UTC
1786476526.234 S -> 2: :My.Little.Server 004 bar My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1786476526.234 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
1786476526.234 S -> 2: :My.Little.Server 422 bar :MOTD File is missing
1786476526.234 S -> 2: :bar!username@localhost MODE bar +
1786476526.234 S -> 2: :My.Little.Server NOTICE bar :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1786476526.234 S -> 2: :My.Little.Server PONG My.Little.Server :foo
1786476526.234 sable_ircd     #x1B[2m2026-08-11T19:28:46.234296Z#x1B[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
1786476526.234 sable_ircd     #x1B[2m2026-08-11T19:28:46.234347Z#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 synchronize303.294358521"
1786476526.234 sable_ircd     #x1B[2m2026-08-11T19:28:46.234452Z#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 :synchronize303.294358521
1786476526.235 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize303.294358521
1786476526.436 sable_history  #x1B[2m2027-08-11T20:18:25.927931Z#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(1007382506984644665)), timestamp: 1818015505, clock: EventClock(1 => 1007369621558267926, 50 => 1007382255326404664, 99 => 1007369624859586564), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015505 }) }; event clock=EventClock(1 => 1007369621558267926, 50 => 1007382255326404664, 99 => 1007369624859586564) my clock=EventClock(1 => 1007369621558267926, 50 => 1007382255326404664, 99 => 1007369624859586564)
1786476526.436 sable_history  #x1B[2m2027-08-11T20:18:25.929637Z#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
1786476526.479 sable_history  #x1B[2m2027-08-11T20:07:05.418683Z#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(1007379652718829613)), timestamp: 1818014825, clock: EventClock(1 => 1007369401122426895, 50 => 1007379401060589612, 99 => 1007369391161356292), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014825 }) }; event clock=EventClock(1 => 1007369401122426895, 50 => 1007379401060589612, 99 => 1007369391161356292) my clock=EventClock(1 => 1007369401122426895, 50 => 1007379401060589612, 99 => 1007369391161356292)
1786476526.479 sable_history  #x1B[2m2027-08-11T20:07:05.420287Z#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
1786476526.936 2 -> S: JOIN #chan
1786476526.936 sable_ircd     #x1B[2m2026-08-11T19:28:46.936320Z#x1B[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
1786476526.936 sable_ircd     #x1B[2m2026-08-11T19:28:46.936391Z#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"
1786476527.036 2 -> S: PING synchronize304.096426979
1786476527.037 sable_ircd     #x1B[2m2026-08-11T19:28:47.036461Z#x1B[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
1786476527.037 sable_ircd     #x1B[2m2026-08-11T19:28:47.036552Z#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 synchronize304.096426979"
1786476527.037 sable_ircd     #x1B[2m2026-08-11T19:28:47.036758Z#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 473 bar #chan :Cannot join channel (+i) - you must be invited
1786476527.037 sable_ircd     #x1B[2m2026-08-11T19:28:47.036812Z#x1B[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
1786476527.037 S -> 2: :My.Little.Server 473 bar #chan :Cannot join channel (+i) - you must be invited
1786476527.864 sable_history  #x1B[2m2027-08-11T20:10:51.133807Z#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(1007380599440351281)), timestamp: 1818015051, clock: EventClock(1 => 1007370015864786977, 50 => 1007380347773722672, 99 => 1007370023867920389), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015051 }) }; event clock=EventClock(1 => 1007370015864786977, 50 => 1007380347773722672, 99 => 1007370023867920389) my clock=EventClock(1 => 1007370015864786977, 50 => 1007380347773722672, 99 => 1007370023867920389)
1786476527.865 sable_history  #x1B[2m2027-08-11T20:10:51.135304Z#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
1786476528.038 2: waiting…
1786476528.042 sable_ircd     #x1B[2m2026-08-11T19:28:48.042338Z#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 :synchronize304.096426979
1786476528.043 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize304.096426979
1786476528.043 1 -> S: INVITE bar #chan
1786476528.043 sable_ircd     #x1B[2m2026-08-11T19:28:48.043092Z#x1B[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
1786476528.043 sable_ircd     #x1B[2m2026-08-11T19:28:48.043136Z#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"INVITE bar #chan"
1786476528.043 sable_ircd     #x1B[2m2026-08-11T19:28:48.043264Z#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 341 foo bar #chan
1786476528.043 sable_ircd     #x1B[2m2026-08-11T19:28:48.043300Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mStateChange(Invite(InviteId(UserId(Snowflake(875098437874356227)), ChannelId(Snowflake(875098416558903298)))), ChannelInvite(ChannelInvite { source: UserId(Snowflake(875098413186682880)) }))
1786476528.043 sable_ircd     #x1B[2m2026-08-11T19:28:48.043408Z#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(875098445889671175)), timestamp: 1786476528, clock: EventClock(1 => 875098437874356230), target: Invite(InviteId(UserId(Snowflake(875098437874356227)), ChannelId(Snowflake(875098416558903298)))), details: ChannelInvite(ChannelInvite { source: UserId(Snowflake(875098413186682880)) }) }; event clock=EventClock(1 => 875098437874356230) my clock=EventClock(1 => 875098437874356230)
1786476528.044 sable_ircd     #x1B[2m2026-08-11T19:28:48.043488Z#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
1786476528.044 sable_ircd     #x1B[2m2026-08-11T19:28:48.043793Z#x1B[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(875098445889671175)), timestamp: 1786476528, change: ChannelInvite(ChannelInvite { invite: InviteId(UserId(Snowflake(875098437874356227)), ChannelId(Snowflake(875098416558903298))), source: User(HistoricUserId(UserId(Snowflake(875098413186682880)), 2)), user: HistoricUserId(UserId(Snowflake(875098437874356227)), 2) }), users_to_notify: [UserId(Snowflake(875098437874356227))] })
1786476528.044 sable_ircd     #x1B[2m2026-08-11T19:28:48.043837Z#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(875098445889671175)), timestamp: 1786476528, change: ChannelInvite(ChannelInvite { invite: InviteId(UserId(Snowflake(875098437874356227)), ChannelId(Snowflake(875098416558903298))), source: User(HistoricUserId(UserId(Snowflake(875098413186682880)), 2)), user: HistoricUserId(UserId(Snowflake(875098437874356227)), 2) }), users_to_notify: [UserId(Snowflake(875098437874356227))] }
1786476528.044 sable_ircd     #x1B[2m2026-08-11T19:28:48.043888Z#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): :foo!username@localhost INVITE bar :#chan
1786476528.044 sable_ircd     #x1B[2m2026-08-11T19:28:48.043929Z#x1B[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(875098445889671175)), timestamp: 1786476528, change: EventComplete(EventComplete), users_to_notify: [] })
1786476528.044 sable_ircd     #x1B[2m2026-08-11T19:28:48.043949Z#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(875098445889671175)), timestamp: 1786476528, change: EventComplete(EventComplete), users_to_notify: [] }
1786476528.060 sable_history  #x1B[2m2027-08-11T20:08:02.835852Z#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(1007379893547376685)), timestamp: 1818014882, clock: EventClock(1 => 1007369312341594113, 50 => 1007379641889136684), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014882 }) }; event clock=EventClock(1 => 1007369312341594113, 50 => 1007379641889136684) my clock=EventClock(1 => 1007369312341594113, 50 => 1007379641889136684)
1786476528.060 sable_history  #x1B[2m2027-08-11T20:08:02.837700Z#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
1786476528.143 1 -> S: PING synchronize305.203409188
1786476528.143 S -> 1: :My.Little.Server 341 foo bar #chan
1786476528.144 sable_ircd     #x1B[2m2026-08-11T19:28:48.143448Z#x1B[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
1786476528.144 sable_ircd     #x1B[2m2026-08-11T19:28:48.143564Z#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 synchronize305.203409188"
1786476528.144 sable_ircd     #x1B[2m2026-08-11T19:28:48.143737Z#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 :synchronize305.203409188
1786476528.144 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize305.203409188
1786476528.244 2 -> S: PING synchronize305.304765342
1786476528.244 S -> 2: :foo!username@localhost INVITE bar :#chan
1786476528.245 sable_ircd     #x1B[2m2026-08-11T19:28:48.245040Z#x1B[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
1786476528.245 sable_ircd     #x1B[2m2026-08-11T19:28:48.245125Z#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 synchronize305.304765342"
1786476528.560 sable_history  #x1B[2m2027-08-11T20:08:03.442793Z#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(1007379896093319213)), timestamp: 1818014883, clock: EventClock(1 => 1007369314333888513, 50 => 1007379644430884908), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014883 }) }; event clock=EventClock(1 => 1007369314333888513, 50 => 1007379644430884908) my clock=EventClock(1 => 1007369314333888513, 50 => 1007379644430884908)
1786476528.560 sable_history  #x1B[2m2027-08-11T20:08:03.444796Z#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
1786476528.876 sable_history  #x1B[2m2027-08-11T20:13:39.717363Z#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(1007381306524508212)), timestamp: 1818015219, clock: EventClock(1 => 1007369718299889686, 50 => 1007381054870462515, 99 => 1007369721508933636), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015219 }) }; event clock=EventClock(1 => 1007369718299889686, 50 => 1007381054870462515, 99 => 1007369721508933636) my clock=EventClock(1 => 1007369718299889686, 50 => 1007381054870462515, 99 => 1007369721508933636)
1786476528.876 sable_history  #x1B[2m2027-08-11T20:13:39.719354Z#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
1786476529.041 sable_history  #x1B[2m2027-08-11T20:08:03.811112Z#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(1007379897636823085)), timestamp: 1818014883, clock: EventClock(1 => 1007369316242296833, 50 => 1007379645982777388), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014883 }) }; event clock=EventClock(1 => 1007369316242296833, 50 => 1007379645982777388) my clock=EventClock(1 => 1007369316242296833, 50 => 1007379645982777388)
1786476529.041 sable_history  #x1B[2m2027-08-11T20:08:03.813292Z#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
1786476529.246 2: waiting…
1786476529.250 sable_ircd     #x1B[2m2026-08-11T19:28:49.250054Z#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 :synchronize305.304765342
1786476529.251 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize305.304765342
1786476529.251 2 -> S: JOIN #chan
1786476529.251 sable_ircd     #x1B[2m2026-08-11T19:28:49.251060Z#x1B[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
1786476529.251 sable_ircd     #x1B[2m2026-08-11T19:28:49.251133Z#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"
1786476529.351 2 -> S: PING synchronize306.411366022
1786476529.352 sable_ircd     #x1B[2m2026-08-11T19:28:49.351502Z#x1B[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
1786476529.352 sable_ircd     #x1B[2m2026-08-11T19:28:49.351623Z#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 synchronize306.411366022"
1786476529.536 sable_history  #x1B[2m2027-08-11T20:16:28.355213Z#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(1007382013847740471)), timestamp: 1818015388, clock: EventClock(1 => 1007369670753259542, 50 => 1007381762189500470, 99 => 1007369673970692100), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015388 }) }; event clock=EventClock(1 => 1007369670753259542, 50 => 1007381762189500470, 99 => 1007369673970692100) my clock=EventClock(1 => 1007369670753259542, 50 => 1007381762189500470, 99 => 1007369673970692100)
1786476529.536 sable_history  #x1B[2m2027-08-11T20:16:28.357124Z#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
1786476529.549 sable_history  #x1B[2m2027-08-11T20:08:04.565891Z#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(1007379900803522605)), timestamp: 1818014884, clock: EventClock(1 => 1007369318356226049, 50 => 1007379649149476908), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014884 }) }; event clock=EventClock(1 => 1007369318356226049, 50 => 1007379649149476908) my clock=EventClock(1 => 1007369318356226049, 50 => 1007379649149476908)
1786476529.550 sable_history  #x1B[2m2027-08-11T20:08:04.567952Z#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
1786476530.059 sable_history  #x1B[2m2027-08-11T20:08:05.940785Z#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(1007379906566496302)), timestamp: 1818014885, clock: EventClock(1 => 1007369320184942593, 50 => 1007379654908256301, 99 => 1007369323750502402), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014885 }) }; event clock=EventClock(1 => 1007369320184942593, 50 => 1007379654908256301, 99 => 1007369323750502402) my clock=EventClock(1 => 1007369320184942593, 50 => 1007379654908256301, 99 => 1007369323750502402)
1786476530.059 sable_history  #x1B[2m2027-08-11T20:08:05.942884Z#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
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.105659Z#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(875098454538326024)), timestamp: 1786476530, clock: EventClock(1 => 875098445889671175), target: Membership(MembershipId(UserId(Snowflake(875098437874356227)), ChannelId(Snowflake(875098416558903298)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(875098416558903298)), user: UserId(Snowflake(875098437874356227)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 875098445889671175) my clock=EventClock(1 => 875098445889671175)
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.105811Z#x1B[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
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.105825Z#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
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.106042Z#x1B[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(875098454538326024)), timestamp: 1786476530, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(875098437874356227)), ChannelId(Snowflake(875098416558903298))), user: HistoricUserId(UserId(Snowflake(875098437874356227)), 2) }), users_to_notify: [UserId(Snowflake(875098413186682880)), UserId(Snowflake(875098437874356227))] })
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.106094Z#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(875098454538326024)), timestamp: 1786476530, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(875098437874356227)), ChannelId(Snowflake(875098416558903298))), user: HistoricUserId(UserId(Snowflake(875098437874356227)), 2) }), users_to_notify: [UserId(Snowflake(875098413186682880)), UserId(Snowflake(875098437874356227))] }
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.106164Z#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
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.106230Z#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
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.106299Z#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 :@foo bar
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.106341Z#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
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.106414Z#x1B[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(875098454538326024)), timestamp: 1786476530, change: EventComplete(EventComplete), users_to_notify: [] })
1786476530.106 sable_ircd     #x1B[2m2026-08-11T19:28:50.106448Z#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(875098454538326024)), timestamp: 1786476530, change: EventComplete(EventComplete), users_to_notify: [] }
1786476530.107 S -> 2: :bar!username@localhost JOIN #chan
1786476530.148 S -> 2: :My.Little.Server 353 bar = #chan :@foo bar
1786476530.148 S -> 2: :My.Little.Server 366 bar #chan :End of names list
1786476530.438 sable_history  #x1B[2m2027-08-11T20:19:25.955440Z#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(1007382758756130874)), timestamp: 1818015565, clock: EventClock(1 => 1007369621558267926, 50 => 1007382506984644665, 99 => 1007369624859586564), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818015565 }) }; event clock=EventClock(1 => 1007369621558267926, 50 => 1007382506984644665, 99 => 1007369624859586564) my clock=EventClock(1 => 1007369621558267926, 50 => 1007382506984644665, 99 => 1007369624859586564)
1786476530.438 sable_history  #x1B[2m2027-08-11T20:19:25.957304Z#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
1786476530.479 sable_history  #x1B[2m2027-08-11T20:08:05.420053Z#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(1007379904385458222)), timestamp: 1818014885, clock: EventClock(1 => 1007369401122426895, 50 => 1007379652718829613, 99 => 1007369391161356292), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1818014885 }) }; event clock=EventClock(1 => 1007369401122426895, 50 => 1007379652718829613, 99 => 1007369391161356292) my clock=EventClock(1 => 1007369401122426895, 50 => 1007379652718829613, 99 => 1007369391161356292)
1786476530.480 sable_history  #x1B[2m2027-08-11T20:08:05.421737Z#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
1786476531.110 sable_ircd     #x1B[2m2026-08-11T19:28:51.110093Z#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 :synchronize306.411366022
1786476531.111 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize306.411366022
1786476531.114 1: disconnects from server.
1786476531.114 2: disconnects from server.