--------------------------------- Captured Out ---------------------------------
---- new test ----
1772747459.125 sable_ircd     uid=1001
1772747459.129 sable_ircd     #x1B[2m2026-03-05T21:50:59.129136Z#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(817514557227405312)), timestamp: 1772747459, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747459, name: ServerName("My.Little.Server"), ts: 1772747459, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1772747459.129 sable_ircd     #x1B[2m2026-03-05T21:50:59.129265Z#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
1772747459.130 sable_ircd     #x1B[2m2026-03-05T21:50:59.129508Z#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(817514557227405312)), timestamp: 1772747459, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747459, name: ServerName("My.Little.Server"), ts: 1772747459, 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
1772747459.130 sable_ircd     #x1B[2m2026-03-05T21:50:59.129630Z#x1B[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(817514557227405312)), timestamp: 1772747459, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1772747459.130 sable_ircd     #x1B[2m2026-03-05T21:50:59.129676Z#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(817514557227405312)), timestamp: 1772747459, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1772747459.130 sable_ircd     #x1B[2m2026-03-05T21:50:59.129753Z#x1B[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(817514557227405312)), timestamp: 1772747459, change: EventComplete(EventComplete), users_to_notify: [] })
1772747459.130 sable_ircd     #x1B[2m2026-03-05T21:50:59.129793Z#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(817514557227405312)), timestamp: 1772747459, change: EventComplete(EventComplete), users_to_notify: [] }
1772747459.131 sable_ircd     #x1B[2m2026-03-05T21:50:59.130698Z#x1B[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
1772747459.131 sable_ircd     #x1B[2m2026-03-05T21:50:59.130722Z#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(817514557231599617)), timestamp: 1772747459, clock: EventClock(1 => 817514557227405312), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1772747459 }) }; event clock=EventClock(1 => 817514557227405312) my clock=EventClock(1 => 817514557227405312)
1772747459.131 sable_ircd     #x1B[2m2026-03-05T21:50:59.130796Z#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
1772747459.131 sable_ircd     #x1B[2m2026-03-05T21:50:59.131025Z#x1B[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(817514557231599617)), timestamp: 1772747459, change: EventComplete(EventComplete), users_to_notify: [] })
1772747459.131 sable_ircd     #x1B[2m2026-03-05T21:50:59.131058Z#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(817514557231599617)), timestamp: 1772747459, change: EventComplete(EventComplete), users_to_notify: [] }
1772747459.221 sable_ircd     #x1B[2m2026-03-05T21:50:59.221004Z#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 }
1772747459.221 sable_ircd     #x1B[2m2026-03-05T21:50:59.221167Z#x1B[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
1772747459.221 sable_ircd     #x1B[2m2026-03-05T21:50:59.221215Z#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
1772747459.221 sable_ircd     #x1B[2m2026-03-05T21:50:59.221275Z#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
1772747459.221 sable_ircd     #x1B[2m2026-03-05T21:50:59.221446Z#x1B[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
1772747459.222 sable_ircd     #x1B[2m2026-03-05T21:50:59.221512Z#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"
1772747459.222 sable_ircd     #x1B[2m2026-03-05T21:50:59.221649Z#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
1772747459.222 sable_ircd     #x1B[2m2026-03-05T21:50:59.221777Z#x1B[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))
1772747459.222 sable_ircd     #x1B[2m2026-03-05T21:50:59.221823Z#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)
1772747459.222 sable_ircd     #x1B[2m2026-03-05T21:50:59.222294Z#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
1772747459.223 sable_ircd     #x1B[2m2026-03-05T21:50:59.222433Z#x1B[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
1772747459.223 sable_ircd     #x1B[2m2026-03-05T21:50:59.222699Z#x1B[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
1772747459.242 chanop: connects to server.
1772747459.242 chanop -> S: NICK chanop
1772747459.242 chanop -> S: USER username * * :Realname
1772747459.242 sable_ircd     #x1B[2m2026-03-05T21:50:59.242291Z#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 }
1772747459.242 sable_ircd     #x1B[2m2026-03-05T21:50:59.242460Z#x1B[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
1772747459.243 sable_ircd     #x1B[2m2026-03-05T21:50:59.242501Z#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
1772747459.243 sable_ircd     #x1B[2m2026-03-05T21:50:59.242555Z#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
1772747459.243 sable_ircd     #x1B[2m2026-03-05T21:50:59.242747Z#x1B[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
1772747459.243 S -> chanop: :My.Little.Server NOTICE * :*** Looking up your hostname
1772747459.243 sable_ircd     #x1B[2m2026-03-05T21:50:59.242819Z#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 chanop"
1772747459.243 sable_ircd     #x1B[2m2026-03-05T21:50:59.243004Z#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: 296, tv_nsec: 579201119 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("chanop")), 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
1772747459.243 sable_ircd     #x1B[2m2026-03-05T21:50:59.243093Z#x1B[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
1772747459.243 sable_ircd     #x1B[2m2026-03-05T21:50:59.243146Z#x1B[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
1772747459.243 sable_ircd     #x1B[2m2026-03-05T21:50:59.243192Z#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"
1772747459.243 sable_ircd     #x1B[2m2026-03-05T21:50:59.243293Z#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: 296, tv_nsec: 579201119 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("chanop")), 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
1772747459.244 sable_ircd     #x1B[2m2026-03-05T21:50:59.243907Z#x1B[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
1772747459.244 sable_ircd     #x1B[2m2026-03-05T21:50:59.243960Z#x1B[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"))
1772747459.244 sable_ircd     #x1B[2m2026-03-05T21:50:59.244005Z#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
1772747459.244 sable_ircd     #x1B[2m2026-03-05T21:50:59.244041Z#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: 296, tv_nsec: 579201119 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("chanop")), 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
1772747459.244 sable_ircd     #x1B[2m2026-03-05T21:50:59.244103Z#x1B[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))
1772747459.245 S -> chanop: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.244430Z#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(817514557709750274)), timestamp: 1772747459, clock: EventClock(1 => 817514557231599617), target: User(UserId(Snowflake(817514557709750272))), details: NewUser(NewUser { nickname: Nickname("chanop"), 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(817514557709750273)), NewUserConnection { user: UserId(Snowflake(817514557709750272)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747459 })) }) }; event clock=EventClock(1 => 817514557231599617) my clock=EventClock(1 => 817514557231599617)
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.244545Z#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
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.244887Z#x1B[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(817514557709750274)), timestamp: 1772747459, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514557709750272)), 1) }), users_to_notify: [] })
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.244929Z#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(817514557709750274)), timestamp: 1772747459, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514557709750272)), 1) }), users_to_notify: [] }
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.244975Z#x1B[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(817514557709750274)), timestamp: 1772747459, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514557709750272)), 2), connection: UserConnectionId(Snowflake(817514557709750273)) }), users_to_notify: [] })
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.244999Z#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(817514557709750274)), timestamp: 1772747459, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514557709750272)), 2), connection: UserConnectionId(Snowflake(817514557709750273)) }), users_to_notify: [] }
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.245049Z#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 chanop :Welcome to the test Internet Relay Chat network, chanop
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.245076Z#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 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.245099Z#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 chanop :This server was created 2026-03-05 21:50:59.245090390 UTC
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.245120Z#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 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.245170Z#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 chanop 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
1772747459.245 sable_ircd     #x1B[2m2026-03-05T21:50:59.245202Z#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 chanop :MOTD File is missing
1772747459.246 S -> chanop: :My.Little.Server 001 chanop :Welcome to the test Internet Relay Chat network, chanop
1772747459.246 S -> chanop: :My.Little.Server 002 chanop :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747459.246 sable_ircd     #x1B[2m2026-03-05T21:50:59.245231Z#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): :chanop!username@localhost MODE chanop +
1772747459.246 sable_ircd     #x1B[2m2026-03-05T21:50:59.245258Z#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 chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747459.246 sable_ircd     #x1B[2m2026-03-05T21:50:59.245293Z#x1B[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(817514557709750274)), timestamp: 1772747459, change: EventComplete(EventComplete), users_to_notify: [] })
1772747459.246 sable_ircd     #x1B[2m2026-03-05T21:50:59.245319Z#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(817514557709750274)), timestamp: 1772747459, change: EventComplete(EventComplete), users_to_notify: [] }
1772747459.246 chanop -> S: PING foo
1772747459.247 sable_ircd     #x1B[2m2026-03-05T21:50:59.246488Z#x1B[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
1772747459.247 sable_ircd     #x1B[2m2026-03-05T21:50:59.246549Z#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"
1772747459.247 sable_ircd     #x1B[2m2026-03-05T21:50:59.246648Z#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
1772747459.446 chanop -> S: PING synchronize296.783033907
1772747459.447 S -> chanop: :My.Little.Server 003 chanop :This server was created 2026-03-05 21:50:59.245090390 UTC
1772747459.447 S -> chanop: :My.Little.Server 004 chanop My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747459.447 S -> chanop: :My.Little.Server 005 chanop 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
1772747459.447 S -> chanop: :My.Little.Server 422 chanop :MOTD File is missing
1772747459.447 S -> chanop: :chanop!username@localhost MODE chanop +
1772747459.447 S -> chanop: :My.Little.Server NOTICE chanop :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747459.447 S -> chanop: :My.Little.Server PONG My.Little.Server :foo
1772747459.447 sable_ircd     #x1B[2m2026-03-05T21:50:59.446944Z#x1B[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
1772747459.447 sable_ircd     #x1B[2m2026-03-05T21:50:59.447024Z#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 synchronize296.783033907"
1772747459.447 sable_ircd     #x1B[2m2026-03-05T21:50:59.447175Z#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 :synchronize296.783033907
1772747459.448 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize296.783033907
1772747460.049 chanop -> S: JOIN #chan
1772747460.049 sable_ircd     #x1B[2m2026-03-05T21:51:00.049246Z#x1B[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
1772747460.049 sable_ircd     #x1B[2m2026-03-05T21:51:00.049326Z#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"
1772747460.050 sable_ircd     #x1B[2m2026-03-05T21:51:00.049692Z#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(817514561086164995)), timestamp: 1772747460, clock: EventClock(1 => 817514557709750274), target: Channel(ChannelId(Snowflake(817514561086164994))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 817514557709750274) my clock=EventClock(1 => 817514557709750274)
1772747460.050 sable_ircd     #x1B[2m2026-03-05T21:51:00.049907Z#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
1772747460.050 sable_ircd     #x1B[2m2026-03-05T21:51:00.049985Z#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(817514561086164996)), timestamp: 1772747460, clock: EventClock(1 => 817514561086164995), target: Membership(MembershipId(UserId(Snowflake(817514557709750272)), ChannelId(Snowflake(817514561086164994)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(817514561086164994)), user: UserId(Snowflake(817514557709750272)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 817514561086164995) my clock=EventClock(1 => 817514561086164995)
1772747460.050 sable_ircd     #x1B[2m2026-03-05T21:51:00.050097Z#x1B[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
1772747460.050 sable_ircd     #x1B[2m2026-03-05T21:51:00.050119Z#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
1772747460.050 sable_ircd     #x1B[2m2026-03-05T21:51:00.050222Z#x1B[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(817514561086164995)), timestamp: 1772747460, change: EventComplete(EventComplete), users_to_notify: [] })
1772747460.050 sable_ircd     #x1B[2m2026-03-05T21:51:00.050265Z#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(817514561086164995)), timestamp: 1772747460, change: EventComplete(EventComplete), users_to_notify: [] }
1772747460.050 sable_ircd     #x1B[2m2026-03-05T21:51:00.050400Z#x1B[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(817514561086164996)), timestamp: 1772747460, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514557709750272)), ChannelId(Snowflake(817514561086164994))), user: HistoricUserId(UserId(Snowflake(817514557709750272)), 2) }), users_to_notify: [UserId(Snowflake(817514557709750272))] })
1772747460.050 sable_ircd     #x1B[2m2026-03-05T21:51:00.050449Z#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(817514561086164996)), timestamp: 1772747460, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514557709750272)), ChannelId(Snowflake(817514561086164994))), user: HistoricUserId(UserId(Snowflake(817514557709750272)), 2) }), users_to_notify: [UserId(Snowflake(817514557709750272))] }
1772747460.051 sable_ircd     #x1B[2m2026-03-05T21:51:00.050524Z#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): :chanop!username@localhost JOIN #chan
1772747460.051 sable_ircd     #x1B[2m2026-03-05T21:51:00.050591Z#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): :chanop!username@localhost MODE #chan +o chanop
1772747460.051 sable_ircd     #x1B[2m2026-03-05T21:51:00.050659Z#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 chanop = #chan :@chanop
1772747460.051 sable_ircd     #x1B[2m2026-03-05T21:51:00.050697Z#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 chanop #chan :End of names list
1772747460.051 sable_ircd     #x1B[2m2026-03-05T21:51:00.050766Z#x1B[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(817514561086164996)), timestamp: 1772747460, change: EventComplete(EventComplete), users_to_notify: [] })
1772747460.051 sable_ircd     #x1B[2m2026-03-05T21:51:00.050799Z#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(817514561086164996)), timestamp: 1772747460, change: EventComplete(EventComplete), users_to_notify: [] }
1772747460.149 chanop -> S: PING synchronize297.485373786
1772747460.149 S -> chanop: :chanop!username@localhost JOIN #chan
1772747460.149 S -> chanop: :chanop!username@localhost MODE #chan +o chanop
1772747460.149 S -> chanop: :My.Little.Server 353 chanop = #chan :@chanop
1772747460.149 S -> chanop: :My.Little.Server 366 chanop #chan :End of names list
1772747460.149 sable_ircd     #x1B[2m2026-03-05T21:51:00.149119Z#x1B[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
1772747460.149 sable_ircd     #x1B[2m2026-03-05T21:51:00.149178Z#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 synchronize297.485373786"
1772747461.150 chanop: waiting…
1772747461.153 sable_ircd     #x1B[2m2026-03-05T21:51:01.153180Z#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 :synchronize297.485373786
1772747461.154 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize297.485373786
1772747461.254 chanop -> S: PING synchronize298.590530253
1772747461.254 sable_ircd     #x1B[2m2026-03-05T21:51:01.254313Z#x1B[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
1772747461.254 sable_ircd     #x1B[2m2026-03-05T21:51:01.254390Z#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.590530253"
1772747462.009 sable_ircd     #x1B[2m2026-03-05T21:51:02.009097Z#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.590530253
1772747462.010 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize298.590530253
1772747462.010 chanop -> S: MODE #chan +I bar!*@*
1772747462.010 sable_ircd     #x1B[2m2026-03-05T21:51:02.010006Z#x1B[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
1772747462.010 sable_ircd     #x1B[2m2026-03-05T21:51:02.010073Z#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 bar!*@*"
1772747462.110 chanop -> S: PING synchronize299.446468202
1772747462.111 sable_ircd     #x1B[2m2026-03-05T21:51:02.110621Z#x1B[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
1772747462.111 sable_ircd     #x1B[2m2026-03-05T21:51:02.110701Z#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.446468202"
1772747463.111 chanop: waiting…
1772747463.116 sable_ircd     #x1B[2m2026-03-05T21:51:03.116273Z#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(817514573950095365)), timestamp: 1772747463, clock: EventClock(1 => 817514561086164996), target: ListModeEntry(ListModeEntryId(Snowflake(817514573950095363))), details: NewListModeEntry(NewListModeEntry { list: ListModeId(ChannelId(Snowflake(817514561086164994)), Invex), pattern: Pattern("bar!*@*"), setter: UserId(Snowflake(817514557709750272)) }) }; event clock=EventClock(1 => 817514561086164996) my clock=EventClock(1 => 817514561086164996)
1772747463.117 sable_ircd     #x1B[2m2026-03-05T21:51:03.116499Z#x1B[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
1772747463.117 sable_ircd     #x1B[2m2026-03-05T21:51:03.116607Z#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
1772747463.117 sable_ircd     #x1B[2m2026-03-05T21:51:03.116891Z#x1B[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(817514573950095365)), timestamp: 1772747463, change: ListModeAdded(ListModeAdded { channel: ChannelId(Snowflake(817514561086164994)), list_type: Invex, pattern: Pattern("bar!*@*"), set_by: User(HistoricUserId(UserId(Snowflake(817514557709750272)), 2)) }), users_to_notify: [UserId(Snowflake(817514557709750272))] })
1772747463.117 sable_ircd     #x1B[2m2026-03-05T21:51:03.116936Z#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(817514573950095365)), timestamp: 1772747463, change: ListModeAdded(ListModeAdded { channel: ChannelId(Snowflake(817514561086164994)), list_type: Invex, pattern: Pattern("bar!*@*"), set_by: User(HistoricUserId(UserId(Snowflake(817514557709750272)), 2)) }), users_to_notify: [UserId(Snowflake(817514557709750272))] }
1772747463.117 sable_ircd     #x1B[2m2026-03-05T21:51:03.117011Z#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): :chanop!username@localhost MODE #chan +I bar!*@*
1772747463.117 sable_ircd     #x1B[2m2026-03-05T21:51:03.117091Z#x1B[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(817514573950095365)), timestamp: 1772747463, change: EventComplete(EventComplete), users_to_notify: [] })
1772747463.117 sable_ircd     #x1B[2m2026-03-05T21:51:03.117127Z#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(817514573950095365)), timestamp: 1772747463, change: EventComplete(EventComplete), users_to_notify: [] }
1772747463.118 S -> chanop: :chanop!username@localhost MODE #chan +I bar!*@*
1772747464.119 chanop: waiting…
1772747464.122 sable_ircd     #x1B[2m2026-03-05T21:51:04.121722Z#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.446468202
1772747464.122 S -> chanop: :My.Little.Server PONG My.Little.Server :synchronize299.446468202
1772747464.122 baz: connects to server.
1772747464.122 baz -> S: NICK Baz
1772747464.122 baz -> S: USER username * * :Realname
1772747464.123 sable_ircd     #x1B[2m2026-03-05T21:51:04.122761Z#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 }
1772747464.123 sable_ircd     #x1B[2m2026-03-05T21:51:04.122876Z#x1B[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
1772747464.123 sable_ircd     #x1B[2m2026-03-05T21:51:04.122921Z#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
1772747464.123 sable_ircd     #x1B[2m2026-03-05T21:51:04.122971Z#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
1772747464.123 sable_ircd     #x1B[2m2026-03-05T21:51:04.123107Z#x1B[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
1772747464.123 sable_ircd     #x1B[2m2026-03-05T21:51:04.123166Z#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 Baz"
1772747464.123 S -> baz: :My.Little.Server NOTICE * :*** Looking up your hostname
1772747464.123 sable_ircd     #x1B[2m2026-03-05T21:51:04.123311Z#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: 301, tv_nsec: 459621728 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("Baz")), realname: OnceLock(<uninit>), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747464.123 sable_ircd     #x1B[2m2026-03-05T21:51:04.123401Z#x1B[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
1772747464.123 sable_ircd     #x1B[2m2026-03-05T21:51:04.123454Z#x1B[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
1772747464.124 sable_ircd     #x1B[2m2026-03-05T21:51:04.123503Z#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"
1772747464.124 sable_ircd     #x1B[2m2026-03-05T21:51:04.123601Z#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: 301, tv_nsec: 459621728 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("Baz")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747464.124 sable_ircd     #x1B[2m2026-03-05T21:51:04.124166Z#x1B[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
1772747464.124 sable_ircd     #x1B[2m2026-03-05T21:51:04.124197Z#x1B[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"))
1772747464.124 sable_ircd     #x1B[2m2026-03-05T21:51:04.124222Z#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
1772747464.124 sable_ircd     #x1B[2m2026-03-05T21:51:04.124244Z#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: 301, tv_nsec: 459621728 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("Baz")), realname: OnceLock(Realname("Realname")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1772747464.124 sable_ircd     #x1B[2m2026-03-05T21:51:04.124283Z#x1B[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))
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.124529Z#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(817514578177953798)), timestamp: 1772747464, clock: EventClock(1 => 817514573950095365), target: User(UserId(Snowflake(817514578177953796))), details: NewUser(NewUser { nickname: Nickname("Baz"), username: Username("username"), visible_hostname: Hostname("localhost"), realname: Realname("Realname"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817514578177953797)), NewUserConnection { user: UserId(Snowflake(817514578177953796)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747464 })) }) }; event clock=EventClock(1 => 817514573950095365) my clock=EventClock(1 => 817514573950095365)
1772747464.125 S -> baz: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.124651Z#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
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.124933Z#x1B[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(817514578177953798)), timestamp: 1772747464, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514578177953796)), 1) }), users_to_notify: [] })
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.124979Z#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(817514578177953798)), timestamp: 1772747464, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817514578177953796)), 1) }), users_to_notify: [] }
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.125066Z#x1B[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(817514578177953798)), timestamp: 1772747464, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514578177953796)), 2), connection: UserConnectionId(Snowflake(817514578177953797)) }), users_to_notify: [] })
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.125104Z#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(817514578177953798)), timestamp: 1772747464, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817514578177953796)), 2), connection: UserConnectionId(Snowflake(817514578177953797)) }), users_to_notify: [] }
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.125170Z#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 Baz :Welcome to the test Internet Relay Chat network, Baz
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.125213Z#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 Baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.125263Z#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 Baz :This server was created 2026-03-05 21:51:04.125246980 UTC
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.125314Z#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 Baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.125393Z#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 Baz EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1772747464.125 sable_ircd     #x1B[2m2026-03-05T21:51:04.125439Z#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 Baz :MOTD File is missing
1772747464.126 sable_ircd     #x1B[2m2026-03-05T21:51:04.125485Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :Baz!username@localhost MODE Baz +
1772747464.126 sable_ircd     #x1B[2m2026-03-05T21:51:04.125523Z#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 Baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747464.126 sable_ircd     #x1B[2m2026-03-05T21:51:04.125587Z#x1B[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(817514578177953798)), timestamp: 1772747464, change: EventComplete(EventComplete), users_to_notify: [] })
1772747464.126 sable_ircd     #x1B[2m2026-03-05T21:51:04.125623Z#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(817514578177953798)), timestamp: 1772747464, change: EventComplete(EventComplete), users_to_notify: [] }
1772747464.126 S -> baz: :My.Little.Server 001 Baz :Welcome to the test Internet Relay Chat network, Baz
1772747464.126 baz -> S: PING foo
1772747464.126 sable_ircd     #x1B[2m2026-03-05T21:51:04.126132Z#x1B[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
1772747464.126 sable_ircd     #x1B[2m2026-03-05T21:51:04.126173Z#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"
1772747464.126 sable_ircd     #x1B[2m2026-03-05T21:51:04.126236Z#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
1772747464.226 baz -> S: PING synchronize301.562729106
1772747464.226 S -> baz: :My.Little.Server 002 Baz :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1772747464.226 S -> baz: :My.Little.Server 003 Baz :This server was created 2026-03-05 21:51:04.125246980 UTC
1772747464.226 S -> baz: :My.Little.Server 004 Baz My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1772747464.226 S -> baz: :My.Little.Server 005 Baz EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1772747464.226 S -> baz: :My.Little.Server 422 Baz :MOTD File is missing
1772747464.226 S -> baz: :Baz!username@localhost MODE Baz +
1772747464.226 S -> baz: :My.Little.Server NOTICE Baz :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1772747464.226 S -> baz: :My.Little.Server PONG My.Little.Server :foo
1772747464.227 sable_ircd     #x1B[2m2026-03-05T21:51:04.226729Z#x1B[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
1772747464.227 sable_ircd     #x1B[2m2026-03-05T21:51:04.226794Z#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 synchronize301.562729106"
1772747464.227 sable_ircd     #x1B[2m2026-03-05T21:51:04.226914Z#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 :synchronize301.562729106
1772747464.227 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize301.562729106
1772747464.928 baz -> S: JOIN #chan
1772747464.929 sable_ircd     #x1B[2m2026-03-05T21:51:04.928488Z#x1B[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
1772747464.929 sable_ircd     #x1B[2m2026-03-05T21:51:04.928540Z#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"
1772747465.028 baz -> S: PING synchronize302.364880993
1772747465.029 sable_ircd     #x1B[2m2026-03-05T21:51:05.028723Z#x1B[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
1772747465.029 sable_ircd     #x1B[2m2026-03-05T21:51:05.028787Z#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 synchronize302.364880993"
1772747465.029 sable_ircd     #x1B[2m2026-03-05T21:51:05.029061Z#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(817514581973798919)), timestamp: 1772747465, clock: EventClock(1 => 817514578177953798), target: Membership(MembershipId(UserId(Snowflake(817514578177953796)), ChannelId(Snowflake(817514561086164994)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(817514561086164994)), user: UserId(Snowflake(817514578177953796)), permissions: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 817514578177953798) my clock=EventClock(1 => 817514578177953798)
1772747465.029 sable_ircd     #x1B[2m2026-03-05T21:51:05.029192Z#x1B[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
1772747465.029 sable_ircd     #x1B[2m2026-03-05T21:51:05.029212Z#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
1772747465.030 sable_ircd     #x1B[2m2026-03-05T21:51:05.029493Z#x1B[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(817514581973798919)), timestamp: 1772747465, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514578177953796)), ChannelId(Snowflake(817514561086164994))), user: HistoricUserId(UserId(Snowflake(817514578177953796)), 2) }), users_to_notify: [UserId(Snowflake(817514557709750272)), UserId(Snowflake(817514578177953796))] })
1772747465.030 sable_ircd     #x1B[2m2026-03-05T21:51:05.029533Z#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(817514581973798919)), timestamp: 1772747465, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(817514578177953796)), ChannelId(Snowflake(817514561086164994))), user: HistoricUserId(UserId(Snowflake(817514578177953796)), 2) }), users_to_notify: [UserId(Snowflake(817514557709750272)), UserId(Snowflake(817514578177953796))] }
1772747465.030 sable_ircd     #x1B[2m2026-03-05T21:51:05.029587Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :Baz!username@localhost JOIN #chan
1772747465.030 sable_ircd     #x1B[2m2026-03-05T21:51:05.029629Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :Baz!username@localhost JOIN #chan
1772747465.030 sable_ircd     #x1B[2m2026-03-05T21:51:05.029675Z#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 Baz = #chan :@chanop Baz
1772747465.030 sable_ircd     #x1B[2m2026-03-05T21:51:05.029698Z#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 Baz #chan :End of names list
1772747465.030 sable_ircd     #x1B[2m2026-03-05T21:51:05.029745Z#x1B[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(817514581973798919)), timestamp: 1772747465, change: EventComplete(EventComplete), users_to_notify: [] })
1772747465.030 sable_ircd     #x1B[2m2026-03-05T21:51:05.029770Z#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(817514581973798919)), timestamp: 1772747465, change: EventComplete(EventComplete), users_to_notify: [] }
1772747465.030 S -> baz: :Baz!username@localhost JOIN #chan
1772747465.030 S -> baz: :My.Little.Server 353 Baz = #chan :@chanop Baz
1772747465.030 S -> baz: :My.Little.Server 366 Baz #chan :End of names list
1772747466.030 baz: waiting…
1772747466.033 sable_ircd     #x1B[2m2026-03-05T21:51:06.033222Z#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 :synchronize302.364880993
1772747466.034 S -> baz: :My.Little.Server PONG My.Little.Server :synchronize302.364880993
1772747466.037 chanop: disconnects from server.
1772747466.037 baz: disconnects from server.