--------------------------------- Captured Out --------------------------------- ---- new test ---- 1793473225.314 sable_ircd uid=1001 1793473225.317 sable_ircd #x1B[2m2026-10-31T19:00:25.317085Z#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(904444721252798464)), timestamp: 1793473225, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1793473225, name: ServerName("My.Little.Server"), ts: 1793473225, flags: (empty), version: "sable-0.1.0-129eb4cfdd7d7f46bf66348a11de99483c5013f5" }) }; event clock=EventClock() my clock=EventClock() 1793473225.317 sable_ircd #x1B[2m2026-10-31T19:00:25.317204Z#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 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.317591Z#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(904444721252798464)), timestamp: 1793473225, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1793473225, name: ServerName("My.Little.Server"), ts: 1793473225, flags: (empty), version: "sable-0.1.0-129eb4cfdd7d7f46bf66348a11de99483c5013f5" }) }#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 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.317705Z#x1B[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(904444721252798464)), timestamp: 1793473225, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.317749Z#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(904444721252798464)), timestamp: 1793473225, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.317807Z#x1B[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(904444721252798464)), timestamp: 1793473225, change: EventComplete(EventComplete), users_to_notify: [] }) 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.318028Z#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(904444721252798464)), timestamp: 1793473225, change: EventComplete(EventComplete), users_to_notify: [] } 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.318089Z#x1B[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 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.317948Z#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(904444721252798465)), timestamp: 1793473225, clock: EventClock(1 => 904444721252798464), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1793473225 }) }; event clock=EventClock(1 => 904444721252798464) my clock=EventClock(1 => 904444721252798464) 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.318198Z#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 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.318401Z#x1B[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(904444721252798465)), timestamp: 1793473225, change: EventComplete(EventComplete), users_to_notify: [] }) 1793473225.318 sable_ircd #x1B[2m2026-10-31T19:00:25.318428Z#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(904444721252798465)), timestamp: 1793473225, change: EventComplete(EventComplete), users_to_notify: [] } 1793473225.410 sable_ircd #x1B[2m2026-10-31T19:00:25.410425Z#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 } 1793473225.411 sable_ircd #x1B[2m2026-10-31T19:00:25.410573Z#x1B[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 1793473225.411 sable_ircd #x1B[2m2026-10-31T19:00:25.410641Z#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 1793473225.411 sable_ircd #x1B[2m2026-10-31T19:00:25.410712Z#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 1793473225.411 sable_ircd #x1B[2m2026-10-31T19:00:25.410905Z#x1B[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 1793473225.411 sable_ircd #x1B[2m2026-10-31T19:00:25.410966Z#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" 1793473225.411 sable_ircd #x1B[2m2026-10-31T19:00:25.411089Z#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 1793473225.411 sable_ircd #x1B[2m2026-10-31T19:00:25.411199Z#x1B[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)) 1793473225.411 sable_ircd #x1B[2m2026-10-31T19:00:25.411230Z#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) 1793473225.412 sable_ircd #x1B[2m2026-10-31T19:00:25.411736Z#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 1793473225.412 sable_ircd #x1B[2m2026-10-31T19:00:25.411852Z#x1B[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 1793473225.412 sable_ircd #x1B[2m2026-10-31T19:00:25.412045Z#x1B[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 1793473225.431 1: connects to server. 1793473225.432 1 -> S: CAP LS 302 1793473225.432 sable_ircd #x1B[2m2026-10-31T19:00:25.431822Z#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 } 1793473225.432 sable_ircd #x1B[2m2026-10-31T19:00:25.431956Z#x1B[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 1793473225.432 sable_ircd #x1B[2m2026-10-31T19:00:25.431995Z#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 1793473225.432 sable_ircd #x1B[2m2026-10-31T19:00:25.432050Z#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 1793473225.432 sable_ircd #x1B[2m2026-10-31T19:00:25.432190Z#x1B[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 1793473225.432 sable_ircd #x1B[2m2026-10-31T19:00:25.432235Z#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"CAP LS 302" 1793473225.432 sable_ircd #x1B[2m2026-10-31T19:00:25.432345Z#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 CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1793473225.433 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1793473225.433 S -> 1: :My.Little.Server CAP * LS :message-tags server-time echo-message batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1793473225.433 1 -> S: CAP REQ :multi-prefix 1793473225.433 sable_ircd #x1B[2m2026-10-31T19:00:25.433000Z#x1B[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 1793473225.433 sable_ircd #x1B[2m2026-10-31T19:00:25.433053Z#x1B[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")) 1793473225.433 sable_ircd #x1B[2m2026-10-31T19:00:25.433087Z#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 1793473225.433 sable_ircd #x1B[2m2026-10-31T19:00:25.433122Z#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: 423, tv_nsec: 90253877 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1793473225.433 sable_ircd #x1B[2m2026-10-31T19:00:25.433343Z#x1B[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 1793473225.433 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost1793473225.433 sable_ircd #x1B[2m2026-10-31T19:00:25.433390Z#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"CAP REQ :multi-prefix" 1793473225.434 sable_ircd #x1B[2m2026-10-31T19:00:25.433552Z#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 CAP * ACK :multi-prefix 1793473225.434 sable_ircd #x1B[2m2026-10-31T19:00:25.433588Z#x1B[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[0mUpdateConnectionCaps(ConnectionId(ListenerId(0), 2), ClientCapabilitySet(512)) 1793473225.474 S -> 1: :My.Little.Server CAP * ACK :multi-prefix 1793473225.474 1 -> S: NICK foo 1793473225.474 1 -> S: USER username * * :Realname 1793473225.474 1 -> S: CAP END 1793473225.474 sable_ircd #x1B[2m2026-10-31T19:00:25.474290Z#x1B[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 1793473225.474 sable_ircd #x1B[2m2026-10-31T19:00:25.474340Z#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" 1793473225.475 sable_ircd #x1B[2m2026-10-31T19:00:25.474458Z#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: 423, tv_nsec: 90253877 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("foo")), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1793473225.475 sable_ircd #x1B[2m2026-10-31T19:00:25.474517Z#x1B[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 1793473225.475 sable_ircd #x1B[2m2026-10-31T19:00:25.474545Z#x1B[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 1793473225.475 sable_ircd #x1B[2m2026-10-31T19:00:25.474572Z#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" 1793473225.475 sable_ircd #x1B[2m2026-10-31T19:00:25.474636Z#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: 423, tv_nsec: 90253877 }, attach_user_id: OnceLock(), 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(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1793473225.475 sable_ircd #x1B[2m2026-10-31T19:00:25.474699Z#x1B[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 1793473225.475 sable_ircd #x1B[2m2026-10-31T19:00:25.474729Z#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"CAP END" 1793473226.228 sable_ircd #x1B[2m2026-10-31T19:00:26.228391Z#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::complete_progress #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 423, tv_nsec: 90253877 }, attach_user_id: OnceLock(), 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(), progress_flags: 0 } #x1B[3mflag#x1B[0m#x1B[2m=#x1B[0mCapNegotiation #x1B[3mresult#x1B[0m#x1B[2m=#x1B[0mtrue 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.228482Z#x1B[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)) 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.228660Z#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(904444725073809410)), timestamp: 1793473226, clock: EventClock(1 => 904444721252798465), target: User(UserId(Snowflake(904444725073809408))), 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(904444725073809409)), NewUserConnection { user: UserId(Snowflake(904444725073809408)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1793473226 })) }) }; event clock=EventClock(1 => 904444721252798465) my clock=EventClock(1 => 904444721252798465) 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.228725Z#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 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.228967Z#x1B[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(904444725073809410)), timestamp: 1793473226, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(904444725073809408)), 1) }), users_to_notify: [] }) 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.228998Z#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(904444725073809410)), timestamp: 1793473226, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(904444725073809408)), 1) }), users_to_notify: [] } 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229037Z#x1B[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(904444725073809410)), timestamp: 1793473226, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(904444725073809408)), 2), connection: UserConnectionId(Snowflake(904444725073809409)) }), users_to_notify: [] }) 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229056Z#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(904444725073809410)), timestamp: 1793473226, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(904444725073809408)), 2), connection: UserConnectionId(Snowflake(904444725073809409)) }), users_to_notify: [] } 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229102Z#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 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229136Z#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-129eb4cfdd7d7f46bf66348a11de99483c5013f5 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229168Z#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-10-31 19:00:26.229156311 UTC 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229193Z#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-129eb4cfdd7d7f46bf66348a11de99483c5013f5 ioZ ntsim bqeIkov 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229241Z#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=16 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229278Z#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 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229308Z#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 + 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229336Z#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. 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229396Z#x1B[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(904444725073809410)), timestamp: 1793473226, change: EventComplete(EventComplete), users_to_notify: [] }) 1793473226.229 sable_ircd #x1B[2m2026-10-31T19:00:26.229425Z#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(904444725073809410)), timestamp: 1793473226, change: EventComplete(EventComplete), users_to_notify: [] } 1793473226.230 S -> 1: :My.Little.Server 001 foo :Welcome to the test Internet Relay Chat network, foo 1793473226.230 1 -> S: PING foo 1793473226.230 sable_ircd #x1B[2m2026-10-31T19:00:26.229887Z#x1B[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 1793473226.230 sable_ircd #x1B[2m2026-10-31T19:00:26.229924Z#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" 1793473226.330 1 -> S: PING synchronize423.987960512 1793473226.330 S -> 1: :My.Little.Server 002 foo :Your host is My.Little.Server, running version sable-0.1.0-129eb4cfdd7d7f46bf66348a11de99483c5013f5 1793473226.330 S -> 1: :My.Little.Server 003 foo :This server was created 2026-10-31 19:00:26.229156311 UTC 1793473226.330 S -> 1: :My.Little.Server 004 foo My.Little.Server sable-0.1.0-129eb4cfdd7d7f46bf66348a11de99483c5013f5 ioZ ntsim bqeIkov 1793473226.330 S -> 1: :My.Little.Server 005 foo EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=16 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1793473226.330 S -> 1: :My.Little.Server 422 foo :MOTD File is missing 1793473226.330 S -> 1: :foo!username@localhost MODE foo + 1793473226.330 S -> 1: :My.Little.Server NOTICE foo :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1793473226.330 sable_ircd #x1B[2m2026-10-31T19:00:26.330127Z#x1B[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 1793473226.330 sable_ircd #x1B[2m2026-10-31T19:00:26.330183Z#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 synchronize423.987960512" 1793473227.085 sable_ircd #x1B[2m2026-10-31T19:00:27.084905Z#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 1793473227.085 S -> 1: :My.Little.Server PONG My.Little.Server :foo 1793473228.086 1: waiting… 1793473228.091 sable_ircd #x1B[2m2026-10-31T19:00:28.090817Z#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 :synchronize423.987960512 1793473228.091 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize423.987960512 1793473228.792 1 -> S: JOIN #chan 1793473228.793 sable_ircd #x1B[2m2026-10-31T19:00:28.792605Z#x1B[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 1793473228.793 sable_ircd #x1B[2m2026-10-31T19:00:28.792672Z#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" 1793473228.892 1 -> S: PING synchronize426.550513287 1793473228.893 sable_ircd #x1B[2m2026-10-31T19:00:28.892885Z#x1B[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 1793473228.893 sable_ircd #x1B[2m2026-10-31T19:00:28.892954Z#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 synchronize426.550513287" 1793473229.145 sable_ircd #x1B[2m2026-10-31T19:00:29.144902Z#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(904444737304399875)), timestamp: 1793473229, clock: EventClock(1 => 904444725073809410), target: Channel(ChannelId(Snowflake(904444737304399874))), details: NewChannel(NewChannel { name: ChannelName("#chan"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 904444725073809410) my clock=EventClock(1 => 904444725073809410) 1793473229.145 sable_ircd #x1B[2m2026-10-31T19:00:29.145126Z#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 1793473229.145 sable_ircd #x1B[2m2026-10-31T19:00:29.145202Z#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(904444737308594180)), timestamp: 1793473229, clock: EventClock(1 => 904444737304399875), target: Membership(MembershipId(UserId(Snowflake(904444725073809408)), ChannelId(Snowflake(904444737304399874)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(904444737304399874)), user: UserId(Snowflake(904444725073809408)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 904444737304399875) my clock=EventClock(1 => 904444737304399875) 1793473229.145 sable_ircd #x1B[2m2026-10-31T19:00:29.145339Z#x1B[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 1793473229.145 sable_ircd #x1B[2m2026-10-31T19:00:29.145421Z#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 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145628Z#x1B[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(904444737304399875)), timestamp: 1793473229, change: EventComplete(EventComplete), users_to_notify: [] }) 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145660Z#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(904444737304399875)), timestamp: 1793473229, change: EventComplete(EventComplete), users_to_notify: [] } 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145701Z#x1B[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(904444737308594180)), timestamp: 1793473229, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(904444725073809408)), ChannelId(Snowflake(904444737304399874))), user: HistoricUserId(UserId(Snowflake(904444725073809408)), 2) }), users_to_notify: [UserId(Snowflake(904444725073809408))] }) 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145722Z#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(904444737308594180)), timestamp: 1793473229, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(904444725073809408)), ChannelId(Snowflake(904444737304399874))), user: HistoricUserId(UserId(Snowflake(904444725073809408)), 2) }), users_to_notify: [UserId(Snowflake(904444725073809408))] } 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145795Z#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 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145839Z#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 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145878Z#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 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145895Z#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 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145938Z#x1B[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(904444737308594180)), timestamp: 1793473229, change: EventComplete(EventComplete), users_to_notify: [] }) 1793473229.146 sable_ircd #x1B[2m2026-10-31T19:00:29.145956Z#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(904444737308594180)), timestamp: 1793473229, change: EventComplete(EventComplete), users_to_notify: [] } 1793473229.146 S -> 1: :foo!username@localhost JOIN #chan 1793473229.146 S -> 1: :foo!username@localhost MODE #chan +o foo 1793473229.146 S -> 1: :My.Little.Server 353 foo = #chan :@foo 1793473229.146 S -> 1: :My.Little.Server 366 foo #chan :End of names list 1793473230.147 1: waiting… 1793473230.152 sable_ircd #x1B[2m2026-10-31T19:00:30.151516Z#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 :synchronize426.550513287 1793473230.152 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize426.550513287 1793473230.152 1 -> S: MODE #chan +v foo 1793473230.152 sable_ircd #x1B[2m2026-10-31T19:00:30.152365Z#x1B[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 1793473230.152 sable_ircd #x1B[2m2026-10-31T19:00:30.152417Z#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 +v foo" 1793473230.252 1 -> S: PING synchronize427.910433605 1793473230.253 sable_ircd #x1B[2m2026-10-31T19:00:30.252695Z#x1B[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 1793473230.253 sable_ircd #x1B[2m2026-10-31T19:00:30.252795Z#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 synchronize427.910433605" 1793473231.007 sable_ircd #x1B[2m2026-10-31T19:00:31.006758Z#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(904444745114193925)), timestamp: 1793473231, clock: EventClock(1 => 904444737308594180), target: Membership(MembershipId(UserId(Snowflake(904444725073809408)), ChannelId(Snowflake(904444737304399874)))), details: MembershipFlagChange(MembershipFlagChange { changed_by: User(UserId(Snowflake(904444725073809408))), added: MembershipFlagSet(2), removed: MembershipFlagSet(0) }) }; event clock=EventClock(1 => 904444737308594180) my clock=EventClock(1 => 904444737308594180) 1793473231.007 sable_ircd #x1B[2m2026-10-31T19:00:31.006965Z#x1B[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 1793473231.007 sable_ircd #x1B[2m2026-10-31T19:00:31.006968Z#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 1793473231.007 sable_ircd #x1B[2m2026-10-31T19:00:31.007235Z#x1B[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(904444745114193925)), timestamp: 1793473231, change: MembershipFlagChange(MembershipFlagChange { membership: MembershipId(UserId(Snowflake(904444725073809408)), ChannelId(Snowflake(904444737304399874))), user: HistoricUserId(UserId(Snowflake(904444725073809408)), 2), added: MembershipFlagSet(2), removed: MembershipFlagSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(904444725073809408)), 2)) }), users_to_notify: [UserId(Snowflake(904444725073809408))] }) 1793473231.007 sable_ircd #x1B[2m2026-10-31T19:00:31.007280Z#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(904444745114193925)), timestamp: 1793473231, change: MembershipFlagChange(MembershipFlagChange { membership: MembershipId(UserId(Snowflake(904444725073809408)), ChannelId(Snowflake(904444737304399874))), user: HistoricUserId(UserId(Snowflake(904444725073809408)), 2), added: MembershipFlagSet(2), removed: MembershipFlagSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(904444725073809408)), 2)) }), users_to_notify: [UserId(Snowflake(904444725073809408))] } 1793473231.007 sable_ircd #x1B[2m2026-10-31T19:00:31.007362Z#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 +v foo 1793473231.007 sable_ircd #x1B[2m2026-10-31T19:00:31.007449Z#x1B[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(904444745114193925)), timestamp: 1793473231, change: EventComplete(EventComplete), users_to_notify: [] }) 1793473231.008 sable_ircd #x1B[2m2026-10-31T19:00:31.007477Z#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(904444745114193925)), timestamp: 1793473231, change: EventComplete(EventComplete), users_to_notify: [] } 1793473231.008 S -> 1: :foo!username@localhost MODE #chan +v foo 1793473232.009 1: waiting… 1793473232.011 sable_ircd #x1B[2m2026-10-31T19:00:32.010983Z#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 :synchronize427.910433605 1793473232.011 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize427.910433605 1793473232.011 1 -> S: NAMES #chan 1793473232.012 sable_ircd #x1B[2m2026-10-31T19:00:32.011674Z#x1B[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 1793473232.012 sable_ircd #x1B[2m2026-10-31T19:00:32.011722Z#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"NAMES #chan" 1793473232.112 1 -> S: PING synchronize429.769744341 1793473232.112 sable_ircd #x1B[2m2026-10-31T19:00:32.111974Z#x1B[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 1793473232.112 sable_ircd #x1B[2m2026-10-31T19:00:32.112037Z#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 synchronize429.769744341" 1793473233.112 1: waiting… 1793473233.118 sable_ircd #x1B[2m2026-10-31T19:00:33.118098Z#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 1793473233.118 sable_ircd #x1B[2m2026-10-31T19:00:33.118147Z#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 1793473233.118 S -> 1: :My.Little.Server 353 foo = #chan :@+foo 1793473233.159 S -> 1: :My.Little.Server 366 foo #chan :End of names list 1793473234.123 sable_ircd #x1B[2m2026-10-31T19:00:34.122681Z#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 :synchronize429.769744341 1793473234.123 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize429.769744341 1793473234.223 1 -> S: PING synchronize431.881491023 1793473234.224 sable_ircd #x1B[2m2026-10-31T19:00:34.223712Z#x1B[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 1793473234.224 sable_ircd #x1B[2m2026-10-31T19:00:34.223763Z#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 synchronize431.881491023" 1793473235.189 sable_ircd #x1B[2m2026-10-31T19:00:35.189196Z#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(904444762658967558)), timestamp: 1793473235, clock: EventClock(1 => 904444510996533253), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1793473235 }) }; event clock=EventClock(1 => 904444510996533253) my clock=EventClock(1 => 904444510996533253) 1793473235.189 sable_ircd #x1B[2m2026-10-31T19:00:35.189273Z#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 1793473235.190 sable_ircd #x1B[2m2026-10-31T19:00:35.189475Z#x1B[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(904444762658967558)), timestamp: 1793473235, change: EventComplete(EventComplete), users_to_notify: [] }) 1793473235.190 sable_ircd #x1B[2m2026-10-31T19:00:35.189519Z#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(904444762658967558)), timestamp: 1793473235, change: EventComplete(EventComplete), users_to_notify: [] } 1793473235.190 sable_ircd #x1B[2m2026-10-31T19:00:35.189691Z#x1B[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 1793473235.224 1: waiting… 1793473235.228 sable_ircd #x1B[2m2026-10-31T19:00:35.227983Z#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 :synchronize431.881491023 1793473235.228 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize431.881491023 1793473235.228 1 -> S: WHO #chan 1793473235.229 sable_ircd #x1B[2m2026-10-31T19:00:35.228668Z#x1B[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 1793473235.229 sable_ircd #x1B[2m2026-10-31T19:00:35.228715Z#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"WHO #chan" 1793473235.329 1 -> S: PING synchronize432.986746584 1793473235.329 sable_ircd #x1B[2m2026-10-31T19:00:35.328956Z#x1B[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 1793473235.329 sable_ircd #x1B[2m2026-10-31T19:00:35.329009Z#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 synchronize432.986746584" 1793473236.083 sable_ircd #x1B[2m2026-10-31T19:00:36.082873Z#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 352 foo #chan username localhost * foo H@+ :0 Realname 1793473236.083 sable_ircd #x1B[2m2026-10-31T19:00:36.082934Z#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 315 foo #chan :End of /WHO list 1793473236.083 S -> 1: :My.Little.Server 352 foo #chan username localhost * foo H@+ :0 Realname 1793473236.120 sable_ircd #x1B[2m2026-10-31T19:00:36.120285Z#x1B[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 1793473236.120 sable_ircd #x1B[2m2026-10-31T19:00:36.120415Z#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(904444766563864582)), timestamp: 1793473236, clock: EventClock(1 => 904444514905624581), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1793473236 }) }; event clock=EventClock(1 => 904444514905624581) my clock=EventClock(1 => 904444514905624581) 1793473236.121 sable_ircd #x1B[2m2026-10-31T19:00:36.120495Z#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 1793473236.121 sable_ircd #x1B[2m2026-10-31T19:00:36.120713Z#x1B[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(904444766563864582)), timestamp: 1793473236, change: EventComplete(EventComplete), users_to_notify: [] }) 1793473236.121 sable_ircd #x1B[2m2026-10-31T19:00:36.120747Z#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(904444766563864582)), timestamp: 1793473236, change: EventComplete(EventComplete), users_to_notify: [] } 1793473236.124 S -> 1: :My.Little.Server 315 foo #chan :End of /WHO list 1793473237.090 sable_ircd #x1B[2m2026-10-31T19:00:37.089445Z#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 :synchronize432.986746584 1793473237.090 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize432.986746584 1793473237.093 1: disconnects from server.