--------------------------------- Captured Out ---------------------------------
---- new test ----
1774291034.250 sable_ircd     uid=1001
1774291034.254 sable_ircd     #x1B[2m2026-03-23T18:37:14.253455Z#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(823988780544299008)), timestamp: 1774291034, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1774291034, name: ServerName("My.Little.Server"), ts: 1774291034, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1774291034.254 sable_ircd     #x1B[2m2026-03-23T18:37:14.253579Z#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
1774291034.254 sable_ircd     #x1B[2m2026-03-23T18:37:14.253809Z#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(823988780544299008)), timestamp: 1774291034, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1774291034, name: ServerName("My.Little.Server"), ts: 1774291034, 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
1774291034.254 sable_ircd     #x1B[2m2026-03-23T18:37:14.254079Z#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(823988780544299008)), timestamp: 1774291034, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1774291034.254 sable_ircd     #x1B[2m2026-03-23T18:37:14.254076Z#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(823988780548493313)), timestamp: 1774291034, clock: EventClock(1 => 823988780544299008), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1774291034 }) }; event clock=EventClock(1 => 823988780544299008) my clock=EventClock(1 => 823988780544299008)
1774291034.254 sable_ircd     #x1B[2m2026-03-23T18:37:14.254186Z#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(823988780544299008)), timestamp: 1774291034, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1774291034.254 sable_ircd     #x1B[2m2026-03-23T18:37:14.254195Z#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
1774291034.254 sable_ircd     #x1B[2m2026-03-23T18:37:14.254291Z#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(823988780544299008)), timestamp: 1774291034, change: EventComplete(EventComplete), users_to_notify: [] })
1774291034.254 sable_ircd     #x1B[2m2026-03-23T18:37:14.254354Z#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(823988780544299008)), timestamp: 1774291034, change: EventComplete(EventComplete), users_to_notify: [] }
1774291034.255 sable_ircd     #x1B[2m2026-03-23T18:37:14.254486Z#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
1774291034.255 sable_ircd     #x1B[2m2026-03-23T18:37:14.254583Z#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(823988780548493313)), timestamp: 1774291034, change: EventComplete(EventComplete), users_to_notify: [] })
1774291034.255 sable_ircd     #x1B[2m2026-03-23T18:37:14.254637Z#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(823988780548493313)), timestamp: 1774291034, change: EventComplete(EventComplete), users_to_notify: [] }
1774291034.346 sable_ircd     #x1B[2m2026-03-23T18:37:14.345817Z#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 }
1774291034.346 sable_ircd     #x1B[2m2026-03-23T18:37:14.345948Z#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
1774291034.346 sable_ircd     #x1B[2m2026-03-23T18:37:14.346003Z#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
1774291034.346 sable_ircd     #x1B[2m2026-03-23T18:37:14.346069Z#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
1774291034.346 sable_ircd     #x1B[2m2026-03-23T18:37:14.346230Z#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
1774291034.346 sable_ircd     #x1B[2m2026-03-23T18:37:14.346294Z#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"
1774291034.346 sable_ircd     #x1B[2m2026-03-23T18:37:14.346414Z#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
1774291034.347 sable_ircd     #x1B[2m2026-03-23T18:37:14.346520Z#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))
1774291034.347 sable_ircd     #x1B[2m2026-03-23T18:37:14.346552Z#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)
1774291034.347 sable_ircd     #x1B[2m2026-03-23T18:37:14.347006Z#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
1774291034.347 sable_ircd     #x1B[2m2026-03-23T18:37:14.347038Z#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
1774291034.347 sable_ircd     #x1B[2m2026-03-23T18:37:14.347102Z#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
1774291034.367 1: connects to server.
1774291034.367 1 -> S: NICK nick1
1774291034.367 1 -> S: USER username * * :Realname
1774291034.367 sable_ircd     #x1B[2m2026-03-23T18:37:14.367008Z#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 }
1774291034.367 sable_ircd     #x1B[2m2026-03-23T18:37:14.367117Z#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
1774291034.367 sable_ircd     #x1B[2m2026-03-23T18:37:14.367162Z#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
1774291034.367 sable_ircd     #x1B[2m2026-03-23T18:37:14.367212Z#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
1774291034.367 sable_ircd     #x1B[2m2026-03-23T18:37:14.367390Z#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
1774291034.368 sable_ircd     #x1B[2m2026-03-23T18:37:14.367496Z#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 nick1"
1774291034.368 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1774291034.368 sable_ircd     #x1B[2m2026-03-23T18:37:14.367641Z#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
1774291034.368 sable_ircd     #x1B[2m2026-03-23T18:37:14.367706Z#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"
1774291034.368 sable_ircd     #x1B[2m2026-03-23T18:37:14.367840Z#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: 343, tv_nsec: 691769586 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(<uninit>), 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
1774291034.368 sable_ircd     #x1B[2m2026-03-23T18:37:14.367940Z#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: 343, tv_nsec: 691769586 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick1")), 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
1774291034.368 sable_ircd     #x1B[2m2026-03-23T18:37:14.368012Z#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
1774291034.368 sable_ircd     #x1B[2m2026-03-23T18:37:14.368453Z#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
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.368493Z#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"))
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.368524Z#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
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.368546Z#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: 343, tv_nsec: 691769586 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick1")), 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
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.368587Z#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))
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.368773Z#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(823988781026643970)), timestamp: 1774291034, clock: EventClock(1 => 823988780548493313), target: User(UserId(Snowflake(823988781026643968))), details: NewUser(NewUser { nickname: Nickname("nick1"), 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(823988781026643969)), NewUserConnection { user: UserId(Snowflake(823988781026643968)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774291034 })) }) }; event clock=EventClock(1 => 823988780548493313) my clock=EventClock(1 => 823988780548493313)
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.368859Z#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
1774291034.369 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369125Z#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(823988781026643970)), timestamp: 1774291034, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(823988781026643968)), 1) }), users_to_notify: [] })
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369165Z#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(823988781026643970)), timestamp: 1774291034, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(823988781026643968)), 1) }), users_to_notify: [] }
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369211Z#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(823988781026643970)), timestamp: 1774291034, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(823988781026643968)), 2), connection: UserConnectionId(Snowflake(823988781026643969)) }), users_to_notify: [] })
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369234Z#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(823988781026643970)), timestamp: 1774291034, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(823988781026643968)), 2), connection: UserConnectionId(Snowflake(823988781026643969)) }), users_to_notify: [] }
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369271Z#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 nick1 :Welcome to the test Internet Relay Chat network, nick1
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369296Z#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 nick1 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369318Z#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 nick1 :This server was created 2026-03-23 18:37:14.369311024 UTC
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369334Z#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 nick1 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369362Z#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 nick1 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
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369382Z#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 nick1 :MOTD File is missing
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369397Z#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): :nick1!username@localhost MODE nick1 +
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369409Z#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 nick1 :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369462Z#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(823988781026643970)), timestamp: 1774291034, change: EventComplete(EventComplete), users_to_notify: [] })
1774291034.369 sable_ircd     #x1B[2m2026-03-23T18:37:14.369487Z#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(823988781026643970)), timestamp: 1774291034, change: EventComplete(EventComplete), users_to_notify: [] }
1774291034.370 S -> 1: :My.Little.Server 001 nick1 :Welcome to the test Internet Relay Chat network, nick1
1774291034.370 S -> 1: :My.Little.Server 002 nick1 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1774291034.370 1 -> S: PING foo
1774291034.370 sable_ircd     #x1B[2m2026-03-23T18:37:14.370020Z#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
1774291034.370 sable_ircd     #x1B[2m2026-03-23T18:37:14.370059Z#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"
1774291034.370 sable_ircd     #x1B[2m2026-03-23T18:37:14.370124Z#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
1774291034.570 1 -> S: PING synchronize343.894521783
1774291034.570 S -> 1: :My.Little.Server 003 nick1 :This server was created 2026-03-23 18:37:14.369311024 UTC
1774291034.570 S -> 1: :My.Little.Server 004 nick1 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1774291034.570 S -> 1: :My.Little.Server 005 nick1 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
1774291034.570 S -> 1: :My.Little.Server 422 nick1 :MOTD File is missing
1774291034.570 S -> 1: :nick1!username@localhost MODE nick1 +
1774291034.570 S -> 1: :My.Little.Server NOTICE nick1 :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1774291034.570 S -> 1: :My.Little.Server PONG My.Little.Server :foo
1774291034.570 sable_ircd     #x1B[2m2026-03-23T18:37:14.570292Z#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
1774291034.570 sable_ircd     #x1B[2m2026-03-23T18:37:14.570337Z#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 synchronize343.894521783"
1774291034.570 sable_ircd     #x1B[2m2026-03-23T18:37:14.570413Z#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 :synchronize343.894521783
1774291034.571 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize343.894521783
1774291035.172 2: connects to server.
1774291035.172 2 -> S: NICK nick2
1774291035.172 2 -> S: USER username * * :Realname
1774291035.172 sable_ircd     #x1B[2m2026-03-23T18:37:15.171895Z#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 }
1774291035.172 sable_ircd     #x1B[2m2026-03-23T18:37:15.172064Z#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
1774291035.172 sable_ircd     #x1B[2m2026-03-23T18:37:15.172112Z#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
1774291035.172 sable_ircd     #x1B[2m2026-03-23T18:37:15.172175Z#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
1774291035.172 sable_ircd     #x1B[2m2026-03-23T18:37:15.172336Z#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
1774291035.172 sable_ircd     #x1B[2m2026-03-23T18:37:15.172389Z#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 nick2"
1774291035.173 S -> 2: :My.Little.Server NOTICE * :*** Looking up your hostname
1774291035.173 sable_ircd     #x1B[2m2026-03-23T18:37:15.172533Z#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: 344, tv_nsec: 496723215 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(Nickname("nick2")), 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
1774291035.173 sable_ircd     #x1B[2m2026-03-23T18:37:15.172592Z#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
1774291035.173 sable_ircd     #x1B[2m2026-03-23T18:37:15.172664Z#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
1774291035.173 sable_ircd     #x1B[2m2026-03-23T18:37:15.172721Z#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"
1774291035.173 sable_ircd     #x1B[2m2026-03-23T18:37:15.172813Z#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: 344, tv_nsec: 496723215 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick2")), 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
1774291035.173 sable_ircd     #x1B[2m2026-03-23T18:37:15.173325Z#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
1774291035.173 sable_ircd     #x1B[2m2026-03-23T18:37:15.173355Z#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"))
1774291035.173 sable_ircd     #x1B[2m2026-03-23T18:37:15.173385Z#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
1774291035.173 sable_ircd     #x1B[2m2026-03-23T18:37:15.173407Z#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: 344, tv_nsec: 496723215 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("username")), extra_user_params: OnceLock(("*", "*")), nick: OnceLock(Nickname("nick2")), 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
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.173477Z#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))
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.173666Z#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(823988784403058691)), timestamp: 1774291035, clock: EventClock(1 => 823988781026643970), target: User(UserId(Snowflake(823988784403058690))), details: NewUser(NewUser { nickname: Nickname("nick2"), 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(823988784403058691)), NewUserConnection { user: UserId(Snowflake(823988784403058690)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1774291035 })) }) }; event clock=EventClock(1 => 823988781026643970) my clock=EventClock(1 => 823988781026643970)
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.173766Z#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
1774291035.174 S -> 2: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174025Z#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(823988784403058691)), timestamp: 1774291035, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(823988784403058690)), 1) }), users_to_notify: [] })
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174059Z#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(823988784403058691)), timestamp: 1774291035, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(823988784403058690)), 1) }), users_to_notify: [] }
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174106Z#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(823988784403058691)), timestamp: 1774291035, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(823988784403058690)), 2), connection: UserConnectionId(Snowflake(823988784403058691)) }), users_to_notify: [] })
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174129Z#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(823988784403058691)), timestamp: 1774291035, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(823988784403058690)), 2), connection: UserConnectionId(Snowflake(823988784403058691)) }), users_to_notify: [] }
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174169Z#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 nick2 :Welcome to the test Internet Relay Chat network, nick2
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174195Z#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 nick2 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174217Z#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 nick2 :This server was created 2026-03-23 18:37:15.174209979 UTC
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174234Z#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 nick2 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174256Z#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 nick2 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
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174274Z#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 nick2 :MOTD File is missing
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174293Z#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): :nick2!username@localhost MODE nick2 +
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174308Z#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 nick2 :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174337Z#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(823988784403058691)), timestamp: 1774291035, change: EventComplete(EventComplete), users_to_notify: [] })
1774291035.174 sable_ircd     #x1B[2m2026-03-23T18:37:15.174357Z#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(823988784403058691)), timestamp: 1774291035, change: EventComplete(EventComplete), users_to_notify: [] }
1774291035.175 S -> 2: :My.Little.Server 001 nick2 :Welcome to the test Internet Relay Chat network, nick2
1774291035.175 S -> 2: :My.Little.Server 002 nick2 :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1774291035.175 2 -> S: PING foo
1774291035.175 sable_ircd     #x1B[2m2026-03-23T18:37:15.174930Z#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
1774291035.175 sable_ircd     #x1B[2m2026-03-23T18:37:15.174971Z#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"
1774291035.175 sable_ircd     #x1B[2m2026-03-23T18:37:15.175040Z#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
1774291035.375 2 -> S: PING synchronize344.699462065
1774291035.375 S -> 2: :My.Little.Server 003 nick2 :This server was created 2026-03-23 18:37:15.174209979 UTC
1774291035.375 S -> 2: :My.Little.Server 004 nick2 My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1774291035.375 S -> 2: :My.Little.Server 005 nick2 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
1774291035.375 S -> 2: :My.Little.Server 422 nick2 :MOTD File is missing
1774291035.375 S -> 2: :nick2!username@localhost MODE nick2 +
1774291035.375 S -> 2: :My.Little.Server NOTICE nick2 :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1774291035.375 S -> 2: :My.Little.Server PONG My.Little.Server :foo
1774291035.375 sable_ircd     #x1B[2m2026-03-23T18:37:15.375388Z#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
1774291035.376 sable_ircd     #x1B[2m2026-03-23T18:37:15.375478Z#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 synchronize344.699462065"
1774291035.376 sable_ircd     #x1B[2m2026-03-23T18:37:15.375595Z#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 :synchronize344.699462065
1774291035.376 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize344.699462065
1774291035.977 2 -> S: JOIN #chan1
1774291035.977 2 -> S: JOIN #chan2
1774291035.977 sable_ircd     #x1B[2m2026-03-23T18:37:15.977343Z#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
1774291035.977 sable_ircd     #x1B[2m2026-03-23T18:37:15.977420Z#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 #chan1"
1774291035.978 sable_ircd     #x1B[2m2026-03-23T18:37:15.977593Z#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
1774291035.978 sable_ircd     #x1B[2m2026-03-23T18:37:15.977639Z#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 #chan2"
1774291036.077 2 -> S: PING synchronize345.401498419
1774291036.078 sable_ircd     #x1B[2m2026-03-23T18:37:16.077633Z#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
1774291036.078 sable_ircd     #x1B[2m2026-03-23T18:37:16.077710Z#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 synchronize345.401498419"
1774291036.078 sable_ircd     #x1B[2m2026-03-23T18:37:16.078047Z#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(823988788198903812)), timestamp: 1774291036, clock: EventClock(1 => 823988784403058691), target: Channel(ChannelId(Snowflake(823988788194709508))), details: NewChannel(NewChannel { name: ChannelName("#chan1"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 823988784403058691) my clock=EventClock(1 => 823988784403058691)
1774291036.078 sable_ircd     #x1B[2m2026-03-23T18:37:16.078212Z#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
1774291036.078 sable_ircd     #x1B[2m2026-03-23T18:37:16.078315Z#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(823988788198903813)), timestamp: 1774291036, clock: EventClock(1 => 823988788198903812), target: Membership(MembershipId(UserId(Snowflake(823988784403058690)), ChannelId(Snowflake(823988788194709508)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(823988788194709508)), user: UserId(Snowflake(823988784403058690)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 823988788198903812) my clock=EventClock(1 => 823988788198903812)
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078465Z#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
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078488Z#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
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078578Z#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(823988788198903812)), timestamp: 1774291036, change: EventComplete(EventComplete), users_to_notify: [] })
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078623Z#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(823988788198903812)), timestamp: 1774291036, change: EventComplete(EventComplete), users_to_notify: [] }
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078741Z#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(823988788198903813)), timestamp: 1774291036, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(823988784403058690)), ChannelId(Snowflake(823988788194709508))), user: HistoricUserId(UserId(Snowflake(823988784403058690)), 2) }), users_to_notify: [UserId(Snowflake(823988784403058690))] })
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078782Z#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(823988788198903813)), timestamp: 1774291036, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(823988784403058690)), ChannelId(Snowflake(823988788194709508))), user: HistoricUserId(UserId(Snowflake(823988784403058690)), 2) }), users_to_notify: [UserId(Snowflake(823988784403058690))] }
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078840Z#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): :nick2!username@localhost JOIN #chan1
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078878Z#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): :nick2!username@localhost MODE #chan1 +o nick2
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078918Z#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 nick2 = #chan1 :@nick2
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078940Z#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 nick2 #chan1 :End of names list
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.078993Z#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(823988788198903813)), timestamp: 1774291036, change: EventComplete(EventComplete), users_to_notify: [] })
1774291036.079 sable_ircd     #x1B[2m2026-03-23T18:37:16.079017Z#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(823988788198903813)), timestamp: 1774291036, change: EventComplete(EventComplete), users_to_notify: [] }
1774291036.079 S -> 2: :nick2!username@localhost JOIN #chan1
1774291036.079 S -> 2: :nick2!username@localhost MODE #chan1 +o nick2
1774291036.079 S -> 2: :My.Little.Server 353 nick2 = #chan1 :@nick2
1774291036.079 S -> 2: :My.Little.Server 366 nick2 #chan1 :End of names list
1774291037.080 2: waiting…
1774291037.085 sable_ircd     #x1B[2m2026-03-23T18:37:17.084685Z#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(823988792418373638)), timestamp: 1774291037, clock: EventClock(1 => 823988788198903813), target: Channel(ChannelId(Snowflake(823988792418373637))), details: NewChannel(NewChannel { name: ChannelName("#chan2"), mode: ChannelMode { modes: ChannelModeSet(0), key: None } }) }; event clock=EventClock(1 => 823988788198903813) my clock=EventClock(1 => 823988788198903813)
1774291037.085 sable_ircd     #x1B[2m2026-03-23T18:37:17.084899Z#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
1774291037.085 sable_ircd     #x1B[2m2026-03-23T18:37:17.084966Z#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(823988792418373639)), timestamp: 1774291037, clock: EventClock(1 => 823988792418373638), target: Membership(MembershipId(UserId(Snowflake(823988784403058690)), ChannelId(Snowflake(823988792418373637)))), details: ChannelJoin(ChannelJoin { channel: ChannelId(Snowflake(823988792418373637)), user: UserId(Snowflake(823988784403058690)), permissions: MembershipFlagSet(1) }) }; event clock=EventClock(1 => 823988792418373638) my clock=EventClock(1 => 823988792418373638)
1774291037.085 sable_ircd     #x1B[2m2026-03-23T18:37:17.085087Z#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
1774291037.085 sable_ircd     #x1B[2m2026-03-23T18:37:17.085085Z#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
1774291037.085 sable_ircd     #x1B[2m2026-03-23T18:37:17.085400Z#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(823988792418373638)), timestamp: 1774291037, change: EventComplete(EventComplete), users_to_notify: [] })
1774291037.085 sable_ircd     #x1B[2m2026-03-23T18:37:17.085460Z#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(823988792418373638)), timestamp: 1774291037, change: EventComplete(EventComplete), users_to_notify: [] }
1774291037.086 sable_ircd     #x1B[2m2026-03-23T18:37:17.085528Z#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(823988792418373639)), timestamp: 1774291037, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(823988784403058690)), ChannelId(Snowflake(823988792418373637))), user: HistoricUserId(UserId(Snowflake(823988784403058690)), 2) }), users_to_notify: [UserId(Snowflake(823988784403058690))] })
1774291037.086 sable_ircd     #x1B[2m2026-03-23T18:37:17.085570Z#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(823988792418373639)), timestamp: 1774291037, change: ChannelJoin(ChannelJoin { membership: MembershipId(UserId(Snowflake(823988784403058690)), ChannelId(Snowflake(823988792418373637))), user: HistoricUserId(UserId(Snowflake(823988784403058690)), 2) }), users_to_notify: [UserId(Snowflake(823988784403058690))] }
1774291037.086 sable_ircd     #x1B[2m2026-03-23T18:37:17.085642Z#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): :nick2!username@localhost JOIN #chan2
1774291037.086 sable_ircd     #x1B[2m2026-03-23T18:37:17.085699Z#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): :nick2!username@localhost MODE #chan2 +o nick2
1774291037.086 sable_ircd     #x1B[2m2026-03-23T18:37:17.085763Z#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 nick2 = #chan2 :@nick2
1774291037.086 sable_ircd     #x1B[2m2026-03-23T18:37:17.085800Z#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 nick2 #chan2 :End of names list
1774291037.086 sable_ircd     #x1B[2m2026-03-23T18:37:17.085848Z#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(823988792418373639)), timestamp: 1774291037, change: EventComplete(EventComplete), users_to_notify: [] })
1774291037.086 sable_ircd     #x1B[2m2026-03-23T18:37:17.085881Z#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(823988792418373639)), timestamp: 1774291037, change: EventComplete(EventComplete), users_to_notify: [] }
1774291037.086 S -> 2: :nick2!username@localhost JOIN #chan2
1774291037.086 S -> 2: :nick2!username@localhost MODE #chan2 +o nick2
1774291037.086 S -> 2: :My.Little.Server 353 nick2 = #chan2 :@nick2
1774291037.086 S -> 2: :My.Little.Server 366 nick2 #chan2 :End of names list
1774291038.087 2: waiting…
1774291038.092 sable_ircd     #x1B[2m2026-03-23T18:37:18.091505Z#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 :synchronize345.401498419
1774291038.092 S -> 2: :My.Little.Server PONG My.Little.Server :synchronize345.401498419
1774291038.192 1 -> S: PING synchronize347.516529205
1774291038.192 sable_ircd     #x1B[2m2026-03-23T18:37:18.192363Z#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
1774291038.192 sable_ircd     #x1B[2m2026-03-23T18:37:18.192422Z#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 synchronize347.516529205"
1774291038.193 sable_ircd     #x1B[2m2026-03-23T18:37:18.192563Z#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 :synchronize347.516529205
1774291038.193 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize347.516529205
1774291038.193 1 -> S: OPER operuser operpassword
1774291038.193 sable_ircd     #x1B[2m2026-03-23T18:37:18.193134Z#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
1774291038.193 sable_ircd     #x1B[2m2026-03-23T18:37:18.193173Z#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"OPER operuser operpassword"
1774291038.256 sable_ircd     #x1B[2m2026-03-23T18:37:18.255833Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2maudit#x1B[0m#x1B[2m:#x1B[0m #x1B[3mid#x1B[0m#x1B[2m=#x1B[0mAuditLogEntryId(Snowflake(823988797329903622)) #x1B[3mcategory#x1B[0m#x1B[2m=#x1B[0mGeneral #x1B[3mtimestamp#x1B[0m#x1B[2m=#x1B[0m1774291038 #x1B[3msource_id#x1B[0m#x1B[2m=#x1B[0mSome(UserId(Snowflake(823988781026643968))) #x1B[3msource_addr#x1B[0m#x1B[2m=#x1B[0mSome(127.0.0.1) #x1B[3msource_str#x1B[0m#x1B[2m=#x1B[0m"nick1!username@localhost[]{127.0.0.1}" #x1B[3maction#x1B[0m#x1B[2m=#x1B[0m"OPER" #x1B[3mtarget_id#x1B[0m#x1B[2m=#x1B[0mNone
1774291038.256 sable_ircd     #x1B[2m2026-03-23T18:37:18.255910Z#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 381 nick1 :You are now an IRC operator
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.256064Z#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(823988797334097928)), timestamp: 1774291038, clock: EventClock(1 => 823988792418373639), target: AuditLogEntry(AuditLogEntryId(Snowflake(823988797329903622))), details: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntry { id: AuditLogEntryId(Snowflake(823988797329903622)), timestamp: 1774291038, category: General, source_id: Some(UserId(Snowflake(823988781026643968))), source_addr: Some(127.0.0.1), source_str: "nick1!username@localhost[]{127.0.0.1}", action: "OPER", target_id: None, target_str: None, target_duration: None, reason: None } }) }; event clock=EventClock(1 => 823988792418373639) my clock=EventClock(1 => 823988792418373639)
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.256140Z#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
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.256564Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mStateChange(User(UserId(Snowflake(823988781026643968))), OperUp(OperUp { oper_name: "operuser" }))
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.256634Z#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(823988797334097928)), timestamp: 1774291038, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(823988797329903622)) }), users_to_notify: [] })
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.256668Z#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(823988797334097928)), timestamp: 1774291038, change: NewAuditLogEntry(NewAuditLogEntry { entry: AuditLogEntryId(Snowflake(823988797329903622)) }), users_to_notify: [] }
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.256739Z#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(823988797334097928)), timestamp: 1774291038, change: EventComplete(EventComplete), users_to_notify: [] })
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.256774Z#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(823988797334097928)), timestamp: 1774291038, change: EventComplete(EventComplete), users_to_notify: [] }
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.256878Z#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(823988797334097929)), timestamp: 1774291038, clock: EventClock(1 => 823988797334097928), target: User(UserId(Snowflake(823988781026643968))), details: OperUp(OperUp { oper_name: "operuser" }) }; event clock=EventClock(1 => 823988797334097928) my clock=EventClock(1 => 823988797334097928)
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.256934Z#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
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.257294Z#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(823988797334097929)), timestamp: 1774291038, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(823988781026643968)), 2), added: UserModeSet(2), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(823988781026643968)), 2)) }), users_to_notify: [UserId(Snowflake(823988781026643968))] })
1774291038.257 sable_ircd     #x1B[2m2026-03-23T18:37:18.257417Z#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(823988797334097929)), timestamp: 1774291038, change: UserModeChange(UserModeChange { user: HistoricUserId(UserId(Snowflake(823988781026643968)), 2), added: UserModeSet(2), removed: UserModeSet(0), changed_by: User(HistoricUserId(UserId(Snowflake(823988781026643968)), 2)) }), users_to_notify: [UserId(Snowflake(823988781026643968))] }
1774291038.258 sable_ircd     #x1B[2m2026-03-23T18:37:18.257555Z#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): :nick1!username@localhost MODE nick1 +o
1774291038.258 sable_ircd     #x1B[2m2026-03-23T18:37:18.257719Z#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(823988797334097929)), timestamp: 1774291038, change: EventComplete(EventComplete), users_to_notify: [] })
1774291038.258 sable_ircd     #x1B[2m2026-03-23T18:37:18.257784Z#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(823988797334097929)), timestamp: 1774291038, change: EventComplete(EventComplete), users_to_notify: [] }
1774291038.293 1 -> S: PING synchronize347.61758594
1774291038.293 S -> 1: :My.Little.Server 381 nick1 :You are now an IRC operator
1774291038.293 S -> 1: :nick1!username@localhost MODE nick1 +o
1774291038.293 sable_ircd     #x1B[2m2026-03-23T18:37:18.293403Z#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
1774291038.294 sable_ircd     #x1B[2m2026-03-23T18:37:18.293500Z#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 synchronize347.61758594"
1774291038.294 sable_ircd     #x1B[2m2026-03-23T18:37:18.293597Z#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 :synchronize347.61758594
1774291038.333 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize347.61758594
1774291038.434 1 -> S: PING synchronize347.75822981
1774291038.434 sable_ircd     #x1B[2m2026-03-23T18:37:18.434176Z#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
1774291038.434 sable_ircd     #x1B[2m2026-03-23T18:37:18.434238Z#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 synchronize347.75822981"
1774291038.434 sable_ircd     #x1B[2m2026-03-23T18:37:18.434380Z#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 :synchronize347.75822981
1774291038.435 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize347.75822981
1774291038.435 1 -> S: WHOIS nick2
1774291038.435 sable_ircd     #x1B[2m2026-03-23T18:37:18.434996Z#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
1774291038.435 sable_ircd     #x1B[2m2026-03-23T18:37:18.435036Z#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"WHOIS nick2"
1774291038.535 1 -> S: PING synchronize347.859449818
1774291038.535 sable_ircd     #x1B[2m2026-03-23T18:37:18.535285Z#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
1774291038.535 sable_ircd     #x1B[2m2026-03-23T18:37:18.535339Z#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 synchronize347.859449818"
1774291039.038 sable_ircd     #x1B[2m2026-03-23T18:37:19.037628Z#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 311 nick1 nick2 username localhost * :Realname
1774291039.038 sable_ircd     #x1B[2m2026-03-23T18:37:19.037701Z#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 312 nick1 nick2 My.Little.Server :ServerId(1)
1774291039.038 sable_ircd     #x1B[2m2026-03-23T18:37:19.037724Z#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 378 nick1 nick2 :is connecting from username@localhost 127.0.0.1
1774291039.038 sable_ircd     #x1B[2m2026-03-23T18:37:19.037739Z#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 318 nick1 nick2 :End of /WHOIS
1774291039.038 S -> 1: :My.Little.Server 311 nick1 nick2 username localhost * :Realname
1774291039.079 S -> 1: :My.Little.Server 312 nick1 nick2 My.Little.Server :ServerId(1)
1774291039.079 S -> 1: :My.Little.Server 378 nick1 nick2 :is connecting from username@localhost 127.0.0.1
1774291039.079 S -> 1: :My.Little.Server 318 nick1 nick2 :End of /WHOIS
1774291040.043 sable_ircd     #x1B[2m2026-03-23T18:37:20.043144Z#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 :synchronize347.859449818
1774291040.044 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize347.859449818
1774291040.047 1: disconnects from server.
1774291040.047 2: disconnects from server.