LCOV - code coverage report
Current view: top level - safekeeper/src - safekeeper.rs (source / functions) Coverage Total Hit
Test: 49aa928ec5b4b510172d8b5c6d154da28e70a46c.info Lines: 85.0 % 911 774
Test Date: 2024-11-13 18:23:39 Functions: 52.5 % 217 114

            Line data    Source code
       1              : //! Acceptor part of proposer-acceptor consensus algorithm.
       2              : 
       3              : use anyhow::{bail, Context, Result};
       4              : use byteorder::{LittleEndian, ReadBytesExt};
       5              : use bytes::{Buf, BufMut, Bytes, BytesMut};
       6              : 
       7              : use postgres_ffi::{TimeLineID, MAX_SEND_SIZE};
       8              : use serde::{Deserialize, Serialize};
       9              : use std::cmp::max;
      10              : use std::cmp::min;
      11              : use std::fmt;
      12              : use std::io::Read;
      13              : use storage_broker::proto::SafekeeperTimelineInfo;
      14              : 
      15              : use tracing::*;
      16              : 
      17              : use crate::control_file;
      18              : use crate::metrics::MISC_OPERATION_SECONDS;
      19              : use crate::send_wal::HotStandbyFeedback;
      20              : 
      21              : use crate::state::TimelineState;
      22              : use crate::wal_storage;
      23              : use pq_proto::SystemId;
      24              : use utils::pageserver_feedback::PageserverFeedback;
      25              : use utils::{
      26              :     bin_ser::LeSer,
      27              :     id::{NodeId, TenantId, TimelineId},
      28              :     lsn::Lsn,
      29              : };
      30              : 
      31              : const SK_PROTOCOL_VERSION: u32 = 2;
      32              : pub const UNKNOWN_SERVER_VERSION: u32 = 0;
      33              : 
      34              : /// Consensus logical timestamp.
      35              : pub type Term = u64;
      36              : pub const INVALID_TERM: Term = 0;
      37              : 
      38            4 : #[derive(Debug, Clone, Copy, Serialize, Deserialize, PartialEq, Eq, PartialOrd, Ord)]
      39              : pub struct TermLsn {
      40              :     pub term: Term,
      41              :     pub lsn: Lsn,
      42              : }
      43              : 
      44              : // Creation from tuple provides less typing (e.g. for unit tests).
      45              : impl From<(Term, Lsn)> for TermLsn {
      46           18 :     fn from(pair: (Term, Lsn)) -> TermLsn {
      47           18 :         TermLsn {
      48           18 :             term: pair.0,
      49           18 :             lsn: pair.1,
      50           18 :         }
      51           18 :     }
      52              : }
      53              : 
      54            5 : #[derive(Clone, Serialize, Deserialize, PartialEq)]
      55              : pub struct TermHistory(pub Vec<TermLsn>);
      56              : 
      57              : impl TermHistory {
      58         1467 :     pub fn empty() -> TermHistory {
      59         1467 :         TermHistory(Vec::new())
      60         1467 :     }
      61              : 
      62              :     // Parse TermHistory as n_entries followed by TermLsn pairs
      63          758 :     pub fn from_bytes(bytes: &mut Bytes) -> Result<TermHistory> {
      64          758 :         if bytes.remaining() < 4 {
      65            0 :             bail!("TermHistory misses len");
      66          758 :         }
      67          758 :         let n_entries = bytes.get_u32_le();
      68          758 :         let mut res = Vec::with_capacity(n_entries as usize);
      69          758 :         for _ in 0..n_entries {
      70         5477 :             if bytes.remaining() < 16 {
      71            0 :                 bail!("TermHistory is incomplete");
      72         5477 :             }
      73         5477 :             res.push(TermLsn {
      74         5477 :                 term: bytes.get_u64_le(),
      75         5477 :                 lsn: bytes.get_u64_le().into(),
      76         5477 :             })
      77              :         }
      78          758 :         Ok(TermHistory(res))
      79          758 :     }
      80              : 
      81              :     /// Return copy of self with switches happening strictly after up_to
      82              :     /// truncated.
      83         3856 :     pub fn up_to(&self, up_to: Lsn) -> TermHistory {
      84         3856 :         let mut res = Vec::with_capacity(self.0.len());
      85        18323 :         for e in &self.0 {
      86        14468 :             if e.lsn > up_to {
      87            1 :                 break;
      88        14467 :             }
      89        14467 :             res.push(*e);
      90              :         }
      91         3856 :         TermHistory(res)
      92         3856 :     }
      93              : 
      94              :     /// Find point of divergence between leader (walproposer) term history and
      95              :     /// safekeeper. Arguments are not symmetric as proposer history ends at
      96              :     /// +infinity while safekeeper at flush_lsn.
      97              :     /// C version is at walproposer SendProposerElected.
      98          764 :     pub fn find_highest_common_point(
      99          764 :         prop_th: &TermHistory,
     100          764 :         sk_th: &TermHistory,
     101          764 :         sk_wal_end: Lsn,
     102          764 :     ) -> Option<TermLsn> {
     103          764 :         let (prop_th, sk_th) = (&prop_th.0, &sk_th.0); // avoid .0 below
     104              : 
     105          764 :         if let Some(sk_th_last) = sk_th.last() {
     106          614 :             assert!(
     107          614 :                 sk_th_last.lsn <= sk_wal_end,
     108            0 :                 "safekeeper term history end {:?} LSN is higher than WAL end {:?}",
     109              :                 sk_th_last,
     110              :                 sk_wal_end
     111              :             );
     112          150 :         }
     113              : 
     114              :         // find last common term, if any...
     115          764 :         let mut last_common_idx = None;
     116         4675 :         for i in 0..min(sk_th.len(), prop_th.len()) {
     117         4675 :             if prop_th[i].term != sk_th[i].term {
     118            9 :                 break;
     119         4666 :             }
     120         4666 :             // If term is the same, LSN must be equal as well.
     121         4666 :             assert!(
     122         4666 :                 prop_th[i].lsn == sk_th[i].lsn,
     123            0 :                 "same term {} has different start LSNs: prop {}, sk {}",
     124            0 :                 prop_th[i].term,
     125            0 :                 prop_th[i].lsn,
     126            0 :                 sk_th[i].lsn
     127              :             );
     128         4666 :             last_common_idx = Some(i);
     129              :         }
     130          764 :         let last_common_idx = match last_common_idx {
     131          152 :             None => return None, // no common point
     132          612 :             Some(lci) => lci,
     133          612 :         };
     134          612 :         // Now find where it ends at both prop and sk and take min. End of
     135          612 :         // (common) term is the start of the next except it is the last one;
     136          612 :         // there it is flush_lsn in case of safekeeper or, in case of proposer
     137          612 :         // +infinity, so we just take flush_lsn then.
     138          612 :         if last_common_idx == prop_th.len() - 1 {
     139           64 :             Some(TermLsn {
     140           64 :                 term: prop_th[last_common_idx].term,
     141           64 :                 lsn: sk_wal_end,
     142           64 :             })
     143              :         } else {
     144          548 :             let prop_common_term_end = prop_th[last_common_idx + 1].lsn;
     145          548 :             let sk_common_term_end = if last_common_idx + 1 < sk_th.len() {
     146            7 :                 sk_th[last_common_idx + 1].lsn
     147              :             } else {
     148          541 :                 sk_wal_end
     149              :             };
     150          548 :             Some(TermLsn {
     151          548 :                 term: prop_th[last_common_idx].term,
     152          548 :                 lsn: min(prop_common_term_end, sk_common_term_end),
     153          548 :             })
     154              :         }
     155          764 :     }
     156              : }
     157              : 
     158              : /// Display only latest entries for Debug.
     159              : impl fmt::Debug for TermHistory {
     160          351 :     fn fmt(&self, fmt: &mut fmt::Formatter) -> fmt::Result {
     161          351 :         let n_printed = 20;
     162          351 :         write!(
     163          351 :             fmt,
     164          351 :             "{}{:?}",
     165          351 :             if self.0.len() > n_printed { "... " } else { "" },
     166          351 :             self.0
     167          351 :                 .iter()
     168          351 :                 .rev()
     169          351 :                 .take(n_printed)
     170         1287 :                 .map(|&e| (e.term, e.lsn)) // omit TermSwitchEntry
     171          351 :                 .collect::<Vec<_>>()
     172          351 :         )
     173          351 :     }
     174              : }
     175              : 
     176              : /// Unique id of proposer. Not needed for correctness, used for monitoring.
     177              : pub type PgUuid = [u8; 16];
     178              : 
     179              : /// Persistent consensus state of the acceptor.
     180            5 : #[derive(Debug, Clone, Serialize, Deserialize, PartialEq)]
     181              : pub struct AcceptorState {
     182              :     /// acceptor's last term it voted for (advanced in 1 phase)
     183              :     pub term: Term,
     184              :     /// History of term switches for safekeeper's WAL.
     185              :     /// Actually it often goes *beyond* WAL contents as we adopt term history
     186              :     /// from the proposer before recovery.
     187              :     pub term_history: TermHistory,
     188              : }
     189              : 
     190              : impl AcceptorState {
     191              :     /// acceptor's last_log_term is the term of the highest entry in the log
     192           43 :     pub fn get_last_log_term(&self, flush_lsn: Lsn) -> Term {
     193           43 :         let th = self.term_history.up_to(flush_lsn);
     194           43 :         match th.0.last() {
     195           37 :             Some(e) => e.term,
     196            6 :             None => 0,
     197              :         }
     198           43 :     }
     199              : }
     200              : 
     201              : /// Information about Postgres. Safekeeper gets it once and then verifies
     202              : /// all further connections from computes match.
     203            3 : #[derive(Debug, Clone, PartialEq, Eq, Serialize, Deserialize)]
     204              : pub struct ServerInfo {
     205              :     /// Postgres server version
     206              :     pub pg_version: u32,
     207              :     pub system_id: SystemId,
     208              :     pub wal_seg_size: u32,
     209              : }
     210              : 
     211            2 : #[derive(Debug, Clone, Serialize, Deserialize, PartialEq)]
     212              : pub struct PersistedPeerInfo {
     213              :     /// LSN up to which safekeeper offloaded WAL to s3.
     214              :     pub backup_lsn: Lsn,
     215              :     /// Term of the last entry.
     216              :     pub term: Term,
     217              :     /// LSN of the last record.
     218              :     pub flush_lsn: Lsn,
     219              :     /// Up to which LSN safekeeper regards its WAL as committed.
     220              :     pub commit_lsn: Lsn,
     221              : }
     222              : 
     223              : impl PersistedPeerInfo {
     224            0 :     pub fn new() -> Self {
     225            0 :         Self {
     226            0 :             backup_lsn: Lsn::INVALID,
     227            0 :             term: INVALID_TERM,
     228            0 :             flush_lsn: Lsn(0),
     229            0 :             commit_lsn: Lsn(0),
     230            0 :         }
     231            0 :     }
     232              : }
     233              : 
     234              : // make clippy happy
     235              : impl Default for PersistedPeerInfo {
     236            0 :     fn default() -> Self {
     237            0 :         Self::new()
     238            0 :     }
     239              : }
     240              : 
     241              : // protocol messages
     242              : 
     243              : /// Initial Proposer -> Acceptor message
     244        20170 : #[derive(Debug, Deserialize)]
     245              : pub struct ProposerGreeting {
     246              :     /// proposer-acceptor protocol version
     247              :     pub protocol_version: u32,
     248              :     /// Postgres server version
     249              :     pub pg_version: u32,
     250              :     pub proposer_id: PgUuid,
     251              :     pub system_id: SystemId,
     252              :     pub timeline_id: TimelineId,
     253              :     pub tenant_id: TenantId,
     254              :     pub tli: TimeLineID,
     255              :     pub wal_seg_size: u32,
     256              : }
     257              : 
     258              : /// Acceptor -> Proposer initial response: the highest term known to me
     259              : /// (acceptor voted for).
     260              : #[derive(Debug, Serialize)]
     261              : pub struct AcceptorGreeting {
     262              :     term: u64,
     263              :     node_id: NodeId,
     264              : }
     265              : 
     266              : /// Vote request sent from proposer to safekeepers
     267         3051 : #[derive(Debug, Deserialize)]
     268              : pub struct VoteRequest {
     269              :     pub term: Term,
     270              : }
     271              : 
     272              : /// Vote itself, sent from safekeeper to proposer
     273              : #[derive(Debug, Serialize)]
     274              : pub struct VoteResponse {
     275              :     pub term: Term, // safekeeper's current term; if it is higher than proposer's, the compute is out of date.
     276              :     vote_given: u64, // fixme u64 due to padding
     277              :     // Safekeeper flush_lsn (end of WAL) + history of term switches allow
     278              :     // proposer to choose the most advanced one.
     279              :     pub flush_lsn: Lsn,
     280              :     truncate_lsn: Lsn,
     281              :     pub term_history: TermHistory,
     282              :     timeline_start_lsn: Lsn,
     283              : }
     284              : 
     285              : /*
     286              :  * Proposer -> Acceptor message announcing proposer is elected and communicating
     287              :  * term history to it.
     288              :  */
     289              : #[derive(Debug)]
     290              : pub struct ProposerElected {
     291              :     pub term: Term,
     292              :     pub start_streaming_at: Lsn,
     293              :     pub term_history: TermHistory,
     294              :     pub timeline_start_lsn: Lsn,
     295              : }
     296              : 
     297              : /// Request with WAL message sent from proposer to safekeeper. Along the way it
     298              : /// communicates commit_lsn.
     299              : #[derive(Debug)]
     300              : pub struct AppendRequest {
     301              :     pub h: AppendRequestHeader,
     302              :     pub wal_data: Bytes,
     303              : }
     304         3040 : #[derive(Debug, Clone, Deserialize)]
     305              : pub struct AppendRequestHeader {
     306              :     // safekeeper's current term; if it is higher than proposer's, the compute is out of date.
     307              :     pub term: Term,
     308              :     // TODO: remove this field from the protocol, it in unused -- LSN of term
     309              :     // switch can be taken from ProposerElected (as well as from term history).
     310              :     pub term_start_lsn: Lsn,
     311              :     /// start position of message in WAL
     312              :     pub begin_lsn: Lsn,
     313              :     /// end position of message in WAL
     314              :     pub end_lsn: Lsn,
     315              :     /// LSN committed by quorum of safekeepers
     316              :     pub commit_lsn: Lsn,
     317              :     /// minimal LSN which may be needed by proposer to perform recovery of some safekeeper
     318              :     pub truncate_lsn: Lsn,
     319              :     // only for logging/debugging
     320              :     pub proposer_uuid: PgUuid,
     321              : }
     322              : 
     323              : /// Report safekeeper state to proposer
     324              : #[derive(Debug, Serialize, Clone)]
     325              : pub struct AppendResponse {
     326              :     // Current term of the safekeeper; if it is higher than proposer's, the
     327              :     // compute is out of date.
     328              :     pub term: Term,
     329              :     // Flushed end of wal on safekeeper; one should be always mindful from what
     330              :     // term history this value comes, either checking history directly or
     331              :     // observing term being set to one for which WAL truncation is known to have
     332              :     // happened.
     333              :     pub flush_lsn: Lsn,
     334              :     // We report back our awareness about which WAL is committed, as this is
     335              :     // a criterion for walproposer --sync mode exit
     336              :     pub commit_lsn: Lsn,
     337              :     pub hs_feedback: HotStandbyFeedback,
     338              :     pub pageserver_feedback: Option<PageserverFeedback>,
     339              : }
     340              : 
     341              : impl AppendResponse {
     342            0 :     fn term_only(term: Term) -> AppendResponse {
     343            0 :         AppendResponse {
     344            0 :             term,
     345            0 :             flush_lsn: Lsn(0),
     346            0 :             commit_lsn: Lsn(0),
     347            0 :             hs_feedback: HotStandbyFeedback::empty(),
     348            0 :             pageserver_feedback: None,
     349            0 :         }
     350            0 :     }
     351              : }
     352              : 
     353              : /// Proposer -> Acceptor messages
     354              : #[derive(Debug)]
     355              : pub enum ProposerAcceptorMessage {
     356              :     Greeting(ProposerGreeting),
     357              :     VoteRequest(VoteRequest),
     358              :     Elected(ProposerElected),
     359              :     AppendRequest(AppendRequest),
     360              :     NoFlushAppendRequest(AppendRequest),
     361              :     FlushWAL,
     362              : }
     363              : 
     364              : impl ProposerAcceptorMessage {
     365              :     /// Parse proposer message.
     366        27019 :     pub fn parse(msg_bytes: Bytes) -> Result<ProposerAcceptorMessage> {
     367        27019 :         // xxx using Reader is inefficient but easy to work with bincode
     368        27019 :         let mut stream = msg_bytes.reader();
     369              :         // u64 is here to avoid padding; it will be removed once we stop packing C structs into the wire as is
     370        27019 :         let tag = stream.read_u64::<LittleEndian>()? as u8 as char;
     371        27019 :         match tag {
     372              :             'g' => {
     373        20170 :                 let msg = ProposerGreeting::des_from(&mut stream)?;
     374        20170 :                 Ok(ProposerAcceptorMessage::Greeting(msg))
     375              :             }
     376              :             'v' => {
     377         3051 :                 let msg = VoteRequest::des_from(&mut stream)?;
     378         3051 :                 Ok(ProposerAcceptorMessage::VoteRequest(msg))
     379              :             }
     380              :             'e' => {
     381          758 :                 let mut msg_bytes = stream.into_inner();
     382          758 :                 if msg_bytes.remaining() < 16 {
     383            0 :                     bail!("ProposerElected message is not complete");
     384          758 :                 }
     385          758 :                 let term = msg_bytes.get_u64_le();
     386          758 :                 let start_streaming_at = msg_bytes.get_u64_le().into();
     387          758 :                 let term_history = TermHistory::from_bytes(&mut msg_bytes)?;
     388          758 :                 if msg_bytes.remaining() < 8 {
     389            0 :                     bail!("ProposerElected message is not complete");
     390          758 :                 }
     391          758 :                 let timeline_start_lsn = msg_bytes.get_u64_le().into();
     392          758 :                 let msg = ProposerElected {
     393          758 :                     term,
     394          758 :                     start_streaming_at,
     395          758 :                     timeline_start_lsn,
     396          758 :                     term_history,
     397          758 :                 };
     398          758 :                 Ok(ProposerAcceptorMessage::Elected(msg))
     399              :             }
     400              :             'a' => {
     401              :                 // read header followed by wal data
     402         3040 :                 let hdr = AppendRequestHeader::des_from(&mut stream)?;
     403         3040 :                 let rec_size = hdr
     404         3040 :                     .end_lsn
     405         3040 :                     .checked_sub(hdr.begin_lsn)
     406         3040 :                     .context("begin_lsn > end_lsn in AppendRequest")?
     407              :                     .0 as usize;
     408         3040 :                 if rec_size > MAX_SEND_SIZE {
     409            0 :                     bail!(
     410            0 :                         "AppendRequest is longer than MAX_SEND_SIZE ({})",
     411            0 :                         MAX_SEND_SIZE
     412            0 :                     );
     413         3040 :                 }
     414         3040 : 
     415         3040 :                 let mut wal_data_vec: Vec<u8> = vec![0; rec_size];
     416         3040 :                 stream.read_exact(&mut wal_data_vec)?;
     417         3040 :                 let wal_data = Bytes::from(wal_data_vec);
     418         3040 :                 let msg = AppendRequest { h: hdr, wal_data };
     419         3040 : 
     420         3040 :                 Ok(ProposerAcceptorMessage::AppendRequest(msg))
     421              :             }
     422            0 :             _ => bail!("unknown proposer-acceptor message tag: {}", tag),
     423              :         }
     424        27019 :     }
     425              : 
     426              :     /// The memory size of the message, including byte slices.
     427            0 :     pub fn size(&self) -> usize {
     428              :         const BASE_SIZE: usize = std::mem::size_of::<ProposerAcceptorMessage>();
     429              : 
     430              :         // For most types, the size is just the base enum size including the nested structs. Some
     431              :         // types also contain byte slices; add them.
     432              :         //
     433              :         // We explicitly list all fields, to draw attention here when new fields are added.
     434            0 :         let mut size = BASE_SIZE;
     435            0 :         size += match self {
     436              :             Self::Greeting(ProposerGreeting {
     437              :                 protocol_version: _,
     438              :                 pg_version: _,
     439              :                 proposer_id: _,
     440              :                 system_id: _,
     441              :                 timeline_id: _,
     442              :                 tenant_id: _,
     443              :                 tli: _,
     444              :                 wal_seg_size: _,
     445            0 :             }) => 0,
     446              : 
     447            0 :             Self::VoteRequest(VoteRequest { term: _ }) => 0,
     448              : 
     449              :             Self::Elected(ProposerElected {
     450              :                 term: _,
     451              :                 start_streaming_at: _,
     452              :                 term_history: _,
     453              :                 timeline_start_lsn: _,
     454            0 :             }) => 0,
     455              : 
     456              :             Self::AppendRequest(AppendRequest {
     457              :                 h:
     458              :                     AppendRequestHeader {
     459              :                         term: _,
     460              :                         term_start_lsn: _,
     461              :                         begin_lsn: _,
     462              :                         end_lsn: _,
     463              :                         commit_lsn: _,
     464              :                         truncate_lsn: _,
     465              :                         proposer_uuid: _,
     466              :                     },
     467            0 :                 wal_data,
     468            0 :             }) => wal_data.len(),
     469              : 
     470              :             Self::NoFlushAppendRequest(AppendRequest {
     471              :                 h:
     472              :                     AppendRequestHeader {
     473              :                         term: _,
     474              :                         term_start_lsn: _,
     475              :                         begin_lsn: _,
     476              :                         end_lsn: _,
     477              :                         commit_lsn: _,
     478              :                         truncate_lsn: _,
     479              :                         proposer_uuid: _,
     480              :                     },
     481            0 :                 wal_data,
     482            0 :             }) => wal_data.len(),
     483              : 
     484            0 :             Self::FlushWAL => 0,
     485              :         };
     486              : 
     487            0 :         size
     488            0 :     }
     489              : }
     490              : 
     491              : /// Acceptor -> Proposer messages
     492              : #[derive(Debug)]
     493              : pub enum AcceptorProposerMessage {
     494              :     Greeting(AcceptorGreeting),
     495              :     VoteResponse(VoteResponse),
     496              :     AppendResponse(AppendResponse),
     497              : }
     498              : 
     499              : impl AcceptorProposerMessage {
     500              :     /// Serialize acceptor -> proposer message.
     501        25757 :     pub fn serialize(&self, buf: &mut BytesMut) -> Result<()> {
     502        25757 :         match self {
     503        20170 :             AcceptorProposerMessage::Greeting(msg) => {
     504        20170 :                 buf.put_u64_le('g' as u64);
     505        20170 :                 buf.put_u64_le(msg.term);
     506        20170 :                 buf.put_u64_le(msg.node_id.0);
     507        20170 :             }
     508         3051 :             AcceptorProposerMessage::VoteResponse(msg) => {
     509         3051 :                 buf.put_u64_le('v' as u64);
     510         3051 :                 buf.put_u64_le(msg.term);
     511         3051 :                 buf.put_u64_le(msg.vote_given);
     512         3051 :                 buf.put_u64_le(msg.flush_lsn.into());
     513         3051 :                 buf.put_u64_le(msg.truncate_lsn.into());
     514         3051 :                 buf.put_u32_le(msg.term_history.0.len() as u32);
     515        12617 :                 for e in &msg.term_history.0 {
     516         9566 :                     buf.put_u64_le(e.term);
     517         9566 :                     buf.put_u64_le(e.lsn.into());
     518         9566 :                 }
     519         3051 :                 buf.put_u64_le(msg.timeline_start_lsn.into());
     520              :             }
     521         2536 :             AcceptorProposerMessage::AppendResponse(msg) => {
     522         2536 :                 buf.put_u64_le('a' as u64);
     523         2536 :                 buf.put_u64_le(msg.term);
     524         2536 :                 buf.put_u64_le(msg.flush_lsn.into());
     525         2536 :                 buf.put_u64_le(msg.commit_lsn.into());
     526         2536 :                 buf.put_i64_le(msg.hs_feedback.ts);
     527         2536 :                 buf.put_u64_le(msg.hs_feedback.xmin);
     528         2536 :                 buf.put_u64_le(msg.hs_feedback.catalog_xmin);
     529              : 
     530              :                 // AsyncReadMessage in walproposer.c will not try to decode pageserver_feedback
     531              :                 // if it is not present.
     532         2536 :                 if let Some(ref msg) = msg.pageserver_feedback {
     533            0 :                     msg.serialize(buf);
     534         2536 :                 }
     535              :             }
     536              :         }
     537              : 
     538        25757 :         Ok(())
     539        25757 :     }
     540              : }
     541              : 
     542              : /// Safekeeper implements consensus to reliably persist WAL across nodes.
     543              : /// It controls all WAL disk writes and updates of control file.
     544              : ///
     545              : /// Currently safekeeper processes:
     546              : /// - messages from compute (proposers) and provides replies
     547              : /// - messages from broker peers
     548              : pub struct SafeKeeper<CTRL: control_file::Storage, WAL: wal_storage::Storage> {
     549              :     /// LSN since the proposer safekeeper currently talking to appends WAL;
     550              :     /// determines last_log_term switch point.
     551              :     pub term_start_lsn: Lsn,
     552              : 
     553              :     pub state: TimelineState<CTRL>, // persistent state storage
     554              :     pub wal_store: WAL,
     555              : 
     556              :     node_id: NodeId, // safekeeper's node id
     557              : }
     558              : 
     559              : impl<CTRL, WAL> SafeKeeper<CTRL, WAL>
     560              : where
     561              :     CTRL: control_file::Storage,
     562              :     WAL: wal_storage::Storage,
     563              : {
     564              :     /// Accepts a control file storage containing the safekeeper state.
     565              :     /// State must be initialized, i.e. contain filled `tenant_id`, `timeline_id`
     566              :     /// and `server` (`wal_seg_size` inside it) fields.
     567         8993 :     pub fn new(
     568         8993 :         state: TimelineState<CTRL>,
     569         8993 :         wal_store: WAL,
     570         8993 :         node_id: NodeId,
     571         8993 :     ) -> Result<SafeKeeper<CTRL, WAL>> {
     572         8993 :         if state.tenant_id == TenantId::from([0u8; 16])
     573         8993 :             || state.timeline_id == TimelineId::from([0u8; 16])
     574              :         {
     575            0 :             bail!(
     576            0 :                 "Calling SafeKeeper::new with empty tenant_id ({}) or timeline_id ({})",
     577            0 :                 state.tenant_id,
     578            0 :                 state.timeline_id
     579            0 :             );
     580         8993 :         }
     581         8993 : 
     582         8993 :         Ok(SafeKeeper {
     583         8993 :             term_start_lsn: Lsn(0),
     584         8993 :             state,
     585         8993 :             wal_store,
     586         8993 :             node_id,
     587         8993 :         })
     588         8993 :     }
     589              : 
     590              :     /// Get history of term switches for the available WAL
     591         3813 :     fn get_term_history(&self) -> TermHistory {
     592         3813 :         self.state
     593         3813 :             .acceptor_state
     594         3813 :             .term_history
     595         3813 :             .up_to(self.flush_lsn())
     596         3813 :     }
     597              : 
     598           43 :     pub fn get_last_log_term(&self) -> Term {
     599           43 :         self.state
     600           43 :             .acceptor_state
     601           43 :             .get_last_log_term(self.flush_lsn())
     602           43 :     }
     603              : 
     604              :     /// wal_store wrapper avoiding commit_lsn <= flush_lsn violation when we don't have WAL yet.
     605        12061 :     pub fn flush_lsn(&self) -> Lsn {
     606        12061 :         max(self.wal_store.flush_lsn(), self.state.timeline_start_lsn)
     607        12061 :     }
     608              : 
     609              :     /// Process message from proposer and possibly form reply. Concurrent
     610              :     /// callers must exclude each other.
     611        29563 :     pub async fn process_msg(
     612        29563 :         &mut self,
     613        29563 :         msg: &ProposerAcceptorMessage,
     614        29563 :     ) -> Result<Option<AcceptorProposerMessage>> {
     615        29563 :         match msg {
     616        20170 :             ProposerAcceptorMessage::Greeting(msg) => self.handle_greeting(msg).await,
     617         3053 :             ProposerAcceptorMessage::VoteRequest(msg) => self.handle_vote_request(msg).await,
     618          760 :             ProposerAcceptorMessage::Elected(msg) => self.handle_elected(msg).await,
     619            4 :             ProposerAcceptorMessage::AppendRequest(msg) => {
     620            4 :                 self.handle_append_request(msg, true).await
     621              :             }
     622         3040 :             ProposerAcceptorMessage::NoFlushAppendRequest(msg) => {
     623         3040 :                 self.handle_append_request(msg, false).await
     624              :             }
     625         2536 :             ProposerAcceptorMessage::FlushWAL => self.handle_flush().await,
     626              :         }
     627        29563 :     }
     628              : 
     629              :     /// Handle initial message from proposer: check its sanity and send my
     630              :     /// current term.
     631        20170 :     async fn handle_greeting(
     632        20170 :         &mut self,
     633        20170 :         msg: &ProposerGreeting,
     634        20170 :     ) -> Result<Option<AcceptorProposerMessage>> {
     635        20170 :         // Check protocol compatibility
     636        20170 :         if msg.protocol_version != SK_PROTOCOL_VERSION {
     637            0 :             bail!(
     638            0 :                 "incompatible protocol version {}, expected {}",
     639            0 :                 msg.protocol_version,
     640            0 :                 SK_PROTOCOL_VERSION
     641            0 :             );
     642        20170 :         }
     643        20170 :         /* Postgres major version mismatch is treated as fatal error
     644        20170 :          * because safekeepers parse WAL headers and the format
     645        20170 :          * may change between versions.
     646        20170 :          */
     647        20170 :         if msg.pg_version / 10000 != self.state.server.pg_version / 10000
     648            0 :             && self.state.server.pg_version != UNKNOWN_SERVER_VERSION
     649              :         {
     650            0 :             bail!(
     651            0 :                 "incompatible server version {}, expected {}",
     652            0 :                 msg.pg_version,
     653            0 :                 self.state.server.pg_version
     654            0 :             );
     655        20170 :         }
     656        20170 : 
     657        20170 :         if msg.tenant_id != self.state.tenant_id {
     658            0 :             bail!(
     659            0 :                 "invalid tenant ID, got {}, expected {}",
     660            0 :                 msg.tenant_id,
     661            0 :                 self.state.tenant_id
     662            0 :             );
     663        20170 :         }
     664        20170 :         if msg.timeline_id != self.state.timeline_id {
     665            0 :             bail!(
     666            0 :                 "invalid timeline ID, got {}, expected {}",
     667            0 :                 msg.timeline_id,
     668            0 :                 self.state.timeline_id
     669            0 :             );
     670        20170 :         }
     671        20170 :         if self.state.server.wal_seg_size != msg.wal_seg_size {
     672            0 :             bail!(
     673            0 :                 "invalid wal_seg_size, got {}, expected {}",
     674            0 :                 msg.wal_seg_size,
     675            0 :                 self.state.server.wal_seg_size
     676            0 :             );
     677        20170 :         }
     678        20170 : 
     679        20170 :         // system_id will be updated on mismatch
     680        20170 :         // sync-safekeepers doesn't know sysid and sends 0, ignore it
     681        20170 :         if self.state.server.system_id != msg.system_id && msg.system_id != 0 {
     682            0 :             if self.state.server.system_id != 0 {
     683            0 :                 warn!(
     684            0 :                     "unexpected system ID arrived, got {}, expected {}",
     685            0 :                     msg.system_id, self.state.server.system_id
     686              :                 );
     687            0 :             }
     688              : 
     689            0 :             let mut state = self.state.start_change();
     690            0 :             state.server.system_id = msg.system_id;
     691            0 :             if msg.pg_version != UNKNOWN_SERVER_VERSION {
     692            0 :                 state.server.pg_version = msg.pg_version;
     693            0 :             }
     694            0 :             self.state.finish_change(&state).await?;
     695        20170 :         }
     696              : 
     697        20170 :         info!(
     698            0 :             "processed greeting from walproposer {}, sending term {:?}",
     699         2416 :             msg.proposer_id.map(|b| format!("{:X}", b)).join(""),
     700            0 :             self.state.acceptor_state.term
     701              :         );
     702        20170 :         Ok(Some(AcceptorProposerMessage::Greeting(AcceptorGreeting {
     703        20170 :             term: self.state.acceptor_state.term,
     704        20170 :             node_id: self.node_id,
     705        20170 :         })))
     706        20170 :     }
     707              : 
     708              :     /// Give vote for the given term, if we haven't done that previously.
     709         3053 :     async fn handle_vote_request(
     710         3053 :         &mut self,
     711         3053 :         msg: &VoteRequest,
     712         3053 :     ) -> Result<Option<AcceptorProposerMessage>> {
     713         3053 :         // Once voted, we won't accept data from older proposers; flush
     714         3053 :         // everything we've already received so that new proposer starts
     715         3053 :         // streaming at end of our WAL, without overlap. Currently we truncate
     716         3053 :         // WAL at streaming point, so this avoids truncating already committed
     717         3053 :         // WAL.
     718         3053 :         //
     719         3053 :         // TODO: it would be smoother to not truncate committed piece at
     720         3053 :         // handle_elected instead. Currently not a big deal, as proposer is the
     721         3053 :         // only source of WAL; with peer2peer recovery it would be more
     722         3053 :         // important.
     723         3053 :         self.wal_store.flush_wal().await?;
     724              :         // initialize with refusal
     725         3053 :         let mut resp = VoteResponse {
     726         3053 :             term: self.state.acceptor_state.term,
     727         3053 :             vote_given: false as u64,
     728         3053 :             flush_lsn: self.flush_lsn(),
     729         3053 :             truncate_lsn: self.state.inmem.peer_horizon_lsn,
     730         3053 :             term_history: self.get_term_history(),
     731         3053 :             timeline_start_lsn: self.state.timeline_start_lsn,
     732         3053 :         };
     733         3053 :         if self.state.acceptor_state.term < msg.term {
     734         2893 :             let mut state = self.state.start_change();
     735         2893 :             state.acceptor_state.term = msg.term;
     736         2893 :             // persist vote before sending it out
     737         2893 :             self.state.finish_change(&state).await?;
     738              : 
     739         2893 :             resp.term = self.state.acceptor_state.term;
     740         2893 :             resp.vote_given = true as u64;
     741          160 :         }
     742         3053 :         info!("processed VoteRequest for term {}: {:?}", msg.term, &resp);
     743         3053 :         Ok(Some(AcceptorProposerMessage::VoteResponse(resp)))
     744         3053 :     }
     745              : 
     746              :     /// Form AppendResponse from current state.
     747         2539 :     fn append_response(&self) -> AppendResponse {
     748         2539 :         let ar = AppendResponse {
     749         2539 :             term: self.state.acceptor_state.term,
     750         2539 :             flush_lsn: self.flush_lsn(),
     751         2539 :             commit_lsn: self.state.commit_lsn,
     752         2539 :             // will be filled by the upper code to avoid bothering safekeeper
     753         2539 :             hs_feedback: HotStandbyFeedback::empty(),
     754         2539 :             pageserver_feedback: None,
     755         2539 :         };
     756         2539 :         trace!("formed AppendResponse {:?}", ar);
     757         2539 :         ar
     758         2539 :     }
     759              : 
     760          760 :     async fn handle_elected(
     761          760 :         &mut self,
     762          760 :         msg: &ProposerElected,
     763          760 :     ) -> Result<Option<AcceptorProposerMessage>> {
     764          760 :         let _timer = MISC_OPERATION_SECONDS
     765          760 :             .with_label_values(&["handle_elected"])
     766          760 :             .start_timer();
     767          760 : 
     768          760 :         info!(
     769            0 :             "received ProposerElected {:?}, term={}, last_log_term={}, flush_lsn={}",
     770            0 :             msg,
     771            0 :             self.state.acceptor_state.term,
     772            0 :             self.get_last_log_term(),
     773            0 :             self.flush_lsn()
     774              :         );
     775          760 :         if self.state.acceptor_state.term < msg.term {
     776            2 :             let mut state = self.state.start_change();
     777            2 :             state.acceptor_state.term = msg.term;
     778            2 :             self.state.finish_change(&state).await?;
     779          758 :         }
     780              : 
     781              :         // If our term is higher, ignore the message (next feedback will inform the compute)
     782          760 :         if self.state.acceptor_state.term > msg.term {
     783            0 :             return Ok(None);
     784          760 :         }
     785          760 : 
     786          760 :         // Before truncating WAL check-cross the check divergence point received
     787          760 :         // from the walproposer.
     788          760 :         let sk_th = self.get_term_history();
     789          760 :         let last_common_point = match TermHistory::find_highest_common_point(
     790          760 :             &msg.term_history,
     791          760 :             &sk_th,
     792          760 :             self.flush_lsn(),
     793          760 :         ) {
     794              :             // No common point. Expect streaming from the beginning of the
     795              :             // history like walproposer while we don't have proper init.
     796          151 :             None => *msg.term_history.0.first().ok_or(anyhow::anyhow!(
     797          151 :                 "empty walproposer term history {:?}",
     798          151 :                 msg.term_history
     799          151 :             ))?,
     800          609 :             Some(lcp) => lcp,
     801              :         };
     802              :         // This is expected to happen in a rare race when another connection
     803              :         // from the same walproposer writes + flushes WAL after this connection
     804              :         // sent flush_lsn in VoteRequest; for instance, very late
     805              :         // ProposerElected message delivery after another connection was
     806              :         // established and wrote WAL. In such cases error is transient;
     807              :         // reconnection makes safekeeper send newest term history and flush_lsn
     808              :         // and walproposer recalculates the streaming point. OTOH repeating
     809              :         // error indicates a serious bug.
     810          760 :         if last_common_point.lsn != msg.start_streaming_at {
     811            0 :             bail!("refusing ProposerElected with unexpected truncation point: lcp={:?} start_streaming_at={}, term={}, sk_th={:?} flush_lsn={}, wp_th={:?}",
     812            0 :                     last_common_point, msg.start_streaming_at,
     813            0 :                     self.state.acceptor_state.term, sk_th, self.flush_lsn(), msg.term_history,
     814            0 :             );
     815          760 :         }
     816          760 : 
     817          760 :         // We are also expected to never attempt to truncate committed data.
     818          760 :         assert!(
     819          760 :             msg.start_streaming_at >= self.state.inmem.commit_lsn,
     820            0 :             "attempt to truncate committed data: start_streaming_at={}, commit_lsn={}, term={}, sk_th={:?} flush_lsn={}, wp_th={:?}",
     821            0 :             msg.start_streaming_at, self.state.inmem.commit_lsn,
     822            0 :             self.state.acceptor_state.term, sk_th, self.flush_lsn(), msg.term_history,
     823              :         );
     824              : 
     825              :         // Before first WAL write initialize its segment. It makes first segment
     826              :         // pg_waldump'able because stream from compute doesn't include its
     827              :         // segment and page headers.
     828              :         //
     829              :         // If we fail before first WAL write flush this action would be
     830              :         // repeated, that's ok because it is idempotent.
     831          760 :         if self.wal_store.flush_lsn() == Lsn::INVALID {
     832          150 :             self.wal_store
     833          150 :                 .initialize_first_segment(msg.start_streaming_at)
     834            0 :                 .await?;
     835          610 :         }
     836              : 
     837              :         // truncate wal, update the LSNs
     838          760 :         self.wal_store.truncate_wal(msg.start_streaming_at).await?;
     839              : 
     840              :         // and now adopt term history from proposer
     841              :         {
     842          760 :             let mut state = self.state.start_change();
     843          760 : 
     844          760 :             // Here we learn initial LSN for the first time, set fields
     845          760 :             // interested in that.
     846          760 : 
     847          760 :             if state.timeline_start_lsn == Lsn(0) {
     848              :                 // Remember point where WAL begins globally.
     849          150 :                 state.timeline_start_lsn = msg.timeline_start_lsn;
     850          150 :                 info!(
     851            0 :                     "setting timeline_start_lsn to {:?}",
     852              :                     state.timeline_start_lsn
     853              :                 );
     854          610 :             }
     855          760 :             if state.peer_horizon_lsn == Lsn(0) {
     856          150 :                 // Update peer_horizon_lsn as soon as we know where timeline starts.
     857          150 :                 // It means that peer_horizon_lsn cannot be zero after we know timeline_start_lsn.
     858          150 :                 state.peer_horizon_lsn = msg.timeline_start_lsn;
     859          610 :             }
     860          760 :             if state.local_start_lsn == Lsn(0) {
     861          150 :                 state.local_start_lsn = msg.start_streaming_at;
     862          150 :                 info!("setting local_start_lsn to {:?}", state.local_start_lsn);
     863          610 :             }
     864              :             // Initializing commit_lsn before acking first flushed record is
     865              :             // important to let find_end_of_wal skip the hole in the beginning
     866              :             // of the first segment.
     867              :             //
     868              :             // NB: on new clusters, this happens at the same time as
     869              :             // timeline_start_lsn initialization, it is taken outside to provide
     870              :             // upgrade.
     871          760 :             state.commit_lsn = max(state.commit_lsn, state.timeline_start_lsn);
     872          760 : 
     873          760 :             // Initializing backup_lsn is useful to avoid making backup think it should upload 0 segment.
     874          760 :             state.backup_lsn = max(state.backup_lsn, state.timeline_start_lsn);
     875          760 :             // similar for remote_consistent_lsn
     876          760 :             state.remote_consistent_lsn =
     877          760 :                 max(state.remote_consistent_lsn, state.timeline_start_lsn);
     878          760 : 
     879          760 :             state.acceptor_state.term_history = msg.term_history.clone();
     880          760 :             self.state.finish_change(&state).await?;
     881              :         }
     882              : 
     883          760 :         info!("start receiving WAL since {:?}", msg.start_streaming_at);
     884              : 
     885              :         // Cache LSN where term starts to immediately fsync control file with
     886              :         // commit_lsn once we reach it -- sync-safekeepers finishes when
     887              :         // persisted commit_lsn on majority of safekeepers aligns.
     888          760 :         self.term_start_lsn = match msg.term_history.0.last() {
     889            0 :             None => bail!("proposer elected with empty term history"),
     890          760 :             Some(term_lsn_start) => term_lsn_start.lsn,
     891          760 :         };
     892          760 : 
     893          760 :         Ok(None)
     894          760 :     }
     895              : 
     896              :     /// Advance commit_lsn taking into account what we have locally.
     897              :     ///
     898              :     /// Note: it is assumed that 'WAL we have is from the right term' check has
     899              :     /// already been done outside.
     900         1812 :     async fn update_commit_lsn(&mut self, mut candidate: Lsn) -> Result<()> {
     901         1812 :         // Both peers and walproposer communicate this value, we might already
     902         1812 :         // have a fresher (higher) version.
     903         1812 :         candidate = max(candidate, self.state.inmem.commit_lsn);
     904         1812 :         let commit_lsn = min(candidate, self.flush_lsn());
     905         1812 :         assert!(
     906         1812 :             commit_lsn >= self.state.inmem.commit_lsn,
     907            0 :             "commit_lsn monotonicity violated: old={} new={}",
     908              :             self.state.inmem.commit_lsn,
     909              :             commit_lsn
     910              :         );
     911              : 
     912         1812 :         self.state.inmem.commit_lsn = commit_lsn;
     913         1812 : 
     914         1812 :         // If new commit_lsn reached term switch, force sync of control
     915         1812 :         // file: walproposer in sync mode is very interested when this
     916         1812 :         // happens. Note: this is for sync-safekeepers mode only, as
     917         1812 :         // otherwise commit_lsn might jump over term_start_lsn.
     918         1812 :         if commit_lsn >= self.term_start_lsn && self.state.commit_lsn < self.term_start_lsn {
     919           88 :             self.state.flush().await?;
     920         1724 :         }
     921              : 
     922         1812 :         Ok(())
     923         1812 :     }
     924              : 
     925              :     /// Handle request to append WAL.
     926              :     #[allow(clippy::comparison_chain)]
     927         3044 :     async fn handle_append_request(
     928         3044 :         &mut self,
     929         3044 :         msg: &AppendRequest,
     930         3044 :         require_flush: bool,
     931         3044 :     ) -> Result<Option<AcceptorProposerMessage>> {
     932         3044 :         if self.state.acceptor_state.term < msg.h.term {
     933            0 :             bail!("got AppendRequest before ProposerElected");
     934         3044 :         }
     935         3044 : 
     936         3044 :         // If our term is higher, immediately refuse the message.
     937         3044 :         if self.state.acceptor_state.term > msg.h.term {
     938            0 :             let resp = AppendResponse::term_only(self.state.acceptor_state.term);
     939            0 :             return Ok(Some(AcceptorProposerMessage::AppendResponse(resp)));
     940         3044 :         }
     941         3044 : 
     942         3044 :         // Disallow any non-sequential writes, which can result in gaps or
     943         3044 :         // overwrites. If we need to move the pointer, ProposerElected message
     944         3044 :         // should have truncated WAL first accordingly. Note that the first
     945         3044 :         // condition (WAL rewrite) is quite expected in real world; it happens
     946         3044 :         // when walproposer reconnects to safekeeper and writes some more data
     947         3044 :         // while first connection still gets some packets later. It might be
     948         3044 :         // better to not log this as error! above.
     949         3044 :         let write_lsn = self.wal_store.write_lsn();
     950         3044 :         if write_lsn > msg.h.begin_lsn {
     951            1 :             bail!(
     952            1 :                 "append request rewrites WAL written before, write_lsn={}, msg lsn={}",
     953            1 :                 write_lsn,
     954            1 :                 msg.h.begin_lsn
     955            1 :             );
     956         3043 :         }
     957         3043 :         if write_lsn < msg.h.begin_lsn && write_lsn != Lsn(0) {
     958            0 :             bail!(
     959            0 :                 "append request creates gap in written WAL, write_lsn={}, msg lsn={}",
     960            0 :                 write_lsn,
     961            0 :                 msg.h.begin_lsn,
     962            0 :             );
     963         3043 :         }
     964         3043 : 
     965         3043 :         // Now we know that we are in the same term as the proposer,
     966         3043 :         // processing the message.
     967         3043 : 
     968         3043 :         self.state.inmem.proposer_uuid = msg.h.proposer_uuid;
     969         3043 : 
     970         3043 :         // do the job
     971         3043 :         if !msg.wal_data.is_empty() {
     972          733 :             self.wal_store
     973          733 :                 .write_wal(msg.h.begin_lsn, &msg.wal_data)
     974            0 :                 .await?;
     975         2310 :         }
     976              : 
     977              :         // flush wal to the disk, if required
     978         3043 :         if require_flush {
     979            3 :             self.wal_store.flush_wal().await?;
     980         3040 :         }
     981              : 
     982              :         // Update commit_lsn. It will be flushed to the control file regularly by the timeline
     983              :         // manager, off of the WAL ingest hot path.
     984         3043 :         if msg.h.commit_lsn != Lsn(0) {
     985         1812 :             self.update_commit_lsn(msg.h.commit_lsn).await?;
     986         1231 :         }
     987              :         // Value calculated by walproposer can always lag:
     988              :         // - safekeepers can forget inmem value and send to proposer lower
     989              :         //   persisted one on restart;
     990              :         // - if we make safekeepers always send persistent value,
     991              :         //   any compute restart would pull it down.
     992              :         // Thus, take max before adopting.
     993         3043 :         self.state.inmem.peer_horizon_lsn =
     994         3043 :             max(self.state.inmem.peer_horizon_lsn, msg.h.truncate_lsn);
     995         3043 : 
     996         3043 :         trace!(
     997            0 :             "processed AppendRequest of len {}, begin_lsn={}, end_lsn={:?}, commit_lsn={:?}, truncate_lsn={:?}, flushed={:?}",
     998            0 :             msg.wal_data.len(),
     999              :             msg.h.begin_lsn,
    1000              :             msg.h.end_lsn,
    1001              :             msg.h.commit_lsn,
    1002              :             msg.h.truncate_lsn,
    1003              :             require_flush,
    1004              :         );
    1005              : 
    1006              :         // If flush_lsn hasn't updated, AppendResponse is not very useful.
    1007         3043 :         if !require_flush {
    1008         3040 :             return Ok(None);
    1009            3 :         }
    1010            3 : 
    1011            3 :         let resp = self.append_response();
    1012            3 :         Ok(Some(AcceptorProposerMessage::AppendResponse(resp)))
    1013         3044 :     }
    1014              : 
    1015              :     /// Flush WAL to disk. Return AppendResponse with latest LSNs.
    1016         2536 :     async fn handle_flush(&mut self) -> Result<Option<AcceptorProposerMessage>> {
    1017         2536 :         self.wal_store.flush_wal().await?;
    1018         2536 :         Ok(Some(AcceptorProposerMessage::AppendResponse(
    1019         2536 :             self.append_response(),
    1020         2536 :         )))
    1021         2536 :     }
    1022              : 
    1023              :     /// Update commit_lsn from peer safekeeper data.
    1024            0 :     pub async fn record_safekeeper_info(&mut self, sk_info: &SafekeeperTimelineInfo) -> Result<()> {
    1025            0 :         if (Lsn(sk_info.commit_lsn) != Lsn::INVALID) && (sk_info.last_log_term != INVALID_TERM) {
    1026              :             // Note: the check is too restrictive, generally we can update local
    1027              :             // commit_lsn if our history matches (is part of) history of advanced
    1028              :             // commit_lsn provider.
    1029            0 :             if sk_info.last_log_term == self.get_last_log_term() {
    1030            0 :                 self.update_commit_lsn(Lsn(sk_info.commit_lsn)).await?;
    1031            0 :             }
    1032            0 :         }
    1033            0 :         Ok(())
    1034            0 :     }
    1035              : }
    1036              : 
    1037              : #[cfg(test)]
    1038              : mod tests {
    1039              :     use futures::future::BoxFuture;
    1040              :     use postgres_ffi::{XLogSegNo, WAL_SEGMENT_SIZE};
    1041              : 
    1042              :     use super::*;
    1043              :     use crate::state::{EvictionState, PersistedPeers, TimelinePersistentState};
    1044              :     use std::{ops::Deref, str::FromStr, time::Instant};
    1045              : 
    1046              :     // fake storage for tests
    1047              :     struct InMemoryState {
    1048              :         persisted_state: TimelinePersistentState,
    1049              :     }
    1050              : 
    1051              :     impl control_file::Storage for InMemoryState {
    1052            5 :         async fn persist(&mut self, s: &TimelinePersistentState) -> Result<()> {
    1053            5 :             self.persisted_state = s.clone();
    1054            5 :             Ok(())
    1055            5 :         }
    1056              : 
    1057            0 :         fn last_persist_at(&self) -> Instant {
    1058            0 :             Instant::now()
    1059            0 :         }
    1060              :     }
    1061              : 
    1062              :     impl Deref for InMemoryState {
    1063              :         type Target = TimelinePersistentState;
    1064              : 
    1065           83 :         fn deref(&self) -> &Self::Target {
    1066           83 :             &self.persisted_state
    1067           83 :         }
    1068              :     }
    1069              : 
    1070            3 :     fn test_sk_state() -> TimelinePersistentState {
    1071            3 :         let mut state = TimelinePersistentState::empty();
    1072            3 :         state.server.wal_seg_size = WAL_SEGMENT_SIZE as u32;
    1073            3 :         state.tenant_id = TenantId::from([1u8; 16]);
    1074            3 :         state.timeline_id = TimelineId::from([1u8; 16]);
    1075            3 :         state
    1076            3 :     }
    1077              : 
    1078              :     struct DummyWalStore {
    1079              :         lsn: Lsn,
    1080              :     }
    1081              : 
    1082              :     impl wal_storage::Storage for DummyWalStore {
    1083            4 :         fn write_lsn(&self) -> Lsn {
    1084            4 :             self.lsn
    1085            4 :         }
    1086              : 
    1087           15 :         fn flush_lsn(&self) -> Lsn {
    1088           15 :             self.lsn
    1089           15 :         }
    1090              : 
    1091            2 :         async fn initialize_first_segment(&mut self, _init_lsn: Lsn) -> Result<()> {
    1092            2 :             Ok(())
    1093            2 :         }
    1094              : 
    1095            3 :         async fn write_wal(&mut self, startpos: Lsn, buf: &[u8]) -> Result<()> {
    1096            3 :             self.lsn = startpos + buf.len() as u64;
    1097            3 :             Ok(())
    1098            3 :         }
    1099              : 
    1100            2 :         async fn truncate_wal(&mut self, end_pos: Lsn) -> Result<()> {
    1101            2 :             self.lsn = end_pos;
    1102            2 :             Ok(())
    1103            2 :         }
    1104              : 
    1105            5 :         async fn flush_wal(&mut self) -> Result<()> {
    1106            5 :             Ok(())
    1107            5 :         }
    1108              : 
    1109            0 :         fn remove_up_to(&self, _segno_up_to: XLogSegNo) -> BoxFuture<'static, anyhow::Result<()>> {
    1110            0 :             Box::pin(async { Ok(()) })
    1111            0 :         }
    1112              : 
    1113            0 :         fn get_metrics(&self) -> crate::metrics::WalStorageMetrics {
    1114            0 :             crate::metrics::WalStorageMetrics::default()
    1115            0 :         }
    1116              :     }
    1117              : 
    1118              :     #[tokio::test]
    1119            1 :     async fn test_voting() {
    1120            1 :         let storage = InMemoryState {
    1121            1 :             persisted_state: test_sk_state(),
    1122            1 :         };
    1123            1 :         let wal_store = DummyWalStore { lsn: Lsn(0) };
    1124            1 :         let mut sk = SafeKeeper::new(TimelineState::new(storage), wal_store, NodeId(0)).unwrap();
    1125            1 : 
    1126            1 :         // check voting for 1 is ok
    1127            1 :         let vote_request = ProposerAcceptorMessage::VoteRequest(VoteRequest { term: 1 });
    1128            1 :         let mut vote_resp = sk.process_msg(&vote_request).await;
    1129            1 :         match vote_resp.unwrap() {
    1130            1 :             Some(AcceptorProposerMessage::VoteResponse(resp)) => assert!(resp.vote_given != 0),
    1131            1 :             r => panic!("unexpected response: {:?}", r),
    1132            1 :         }
    1133            1 : 
    1134            1 :         // reboot...
    1135            1 :         let state = sk.state.deref().clone();
    1136            1 :         let storage = InMemoryState {
    1137            1 :             persisted_state: state,
    1138            1 :         };
    1139            1 : 
    1140            1 :         sk = SafeKeeper::new(TimelineState::new(storage), sk.wal_store, NodeId(0)).unwrap();
    1141            1 : 
    1142            1 :         // and ensure voting second time for 1 is not ok
    1143            1 :         vote_resp = sk.process_msg(&vote_request).await;
    1144            1 :         match vote_resp.unwrap() {
    1145            1 :             Some(AcceptorProposerMessage::VoteResponse(resp)) => assert!(resp.vote_given == 0),
    1146            1 :             r => panic!("unexpected response: {:?}", r),
    1147            1 :         }
    1148            1 :     }
    1149              : 
    1150              :     #[tokio::test]
    1151            1 :     async fn test_last_log_term_switch() {
    1152            1 :         let storage = InMemoryState {
    1153            1 :             persisted_state: test_sk_state(),
    1154            1 :         };
    1155            1 :         let wal_store = DummyWalStore { lsn: Lsn(0) };
    1156            1 : 
    1157            1 :         let mut sk = SafeKeeper::new(TimelineState::new(storage), wal_store, NodeId(0)).unwrap();
    1158            1 : 
    1159            1 :         let mut ar_hdr = AppendRequestHeader {
    1160            1 :             term: 2,
    1161            1 :             term_start_lsn: Lsn(3),
    1162            1 :             begin_lsn: Lsn(1),
    1163            1 :             end_lsn: Lsn(2),
    1164            1 :             commit_lsn: Lsn(0),
    1165            1 :             truncate_lsn: Lsn(0),
    1166            1 :             proposer_uuid: [0; 16],
    1167            1 :         };
    1168            1 :         let mut append_request = AppendRequest {
    1169            1 :             h: ar_hdr.clone(),
    1170            1 :             wal_data: Bytes::from_static(b"b"),
    1171            1 :         };
    1172            1 : 
    1173            1 :         let pem = ProposerElected {
    1174            1 :             term: 2,
    1175            1 :             start_streaming_at: Lsn(1),
    1176            1 :             term_history: TermHistory(vec![
    1177            1 :                 TermLsn {
    1178            1 :                     term: 1,
    1179            1 :                     lsn: Lsn(1),
    1180            1 :                 },
    1181            1 :                 TermLsn {
    1182            1 :                     term: 2,
    1183            1 :                     lsn: Lsn(3),
    1184            1 :                 },
    1185            1 :             ]),
    1186            1 :             timeline_start_lsn: Lsn(1),
    1187            1 :         };
    1188            1 :         sk.process_msg(&ProposerAcceptorMessage::Elected(pem))
    1189            1 :             .await
    1190            1 :             .unwrap();
    1191            1 : 
    1192            1 :         // check that AppendRequest before term_start_lsn doesn't switch last_log_term.
    1193            1 :         sk.process_msg(&ProposerAcceptorMessage::AppendRequest(append_request))
    1194            1 :             .await
    1195            1 :             .unwrap();
    1196            1 :         assert_eq!(sk.get_last_log_term(), 1);
    1197            1 : 
    1198            1 :         // but record at term_start_lsn does the switch
    1199            1 :         ar_hdr.begin_lsn = Lsn(2);
    1200            1 :         ar_hdr.end_lsn = Lsn(3);
    1201            1 :         append_request = AppendRequest {
    1202            1 :             h: ar_hdr,
    1203            1 :             wal_data: Bytes::from_static(b"b"),
    1204            1 :         };
    1205            1 :         sk.process_msg(&ProposerAcceptorMessage::AppendRequest(append_request))
    1206            1 :             .await
    1207            1 :             .unwrap();
    1208            1 :         assert_eq!(sk.get_last_log_term(), 2);
    1209            1 :     }
    1210              : 
    1211              :     #[tokio::test]
    1212            1 :     async fn test_non_consecutive_write() {
    1213            1 :         let storage = InMemoryState {
    1214            1 :             persisted_state: test_sk_state(),
    1215            1 :         };
    1216            1 :         let wal_store = DummyWalStore { lsn: Lsn(0) };
    1217            1 : 
    1218            1 :         let mut sk = SafeKeeper::new(TimelineState::new(storage), wal_store, NodeId(0)).unwrap();
    1219            1 : 
    1220            1 :         let pem = ProposerElected {
    1221            1 :             term: 1,
    1222            1 :             start_streaming_at: Lsn(1),
    1223            1 :             term_history: TermHistory(vec![TermLsn {
    1224            1 :                 term: 1,
    1225            1 :                 lsn: Lsn(1),
    1226            1 :             }]),
    1227            1 :             timeline_start_lsn: Lsn(1),
    1228            1 :         };
    1229            1 :         sk.process_msg(&ProposerAcceptorMessage::Elected(pem))
    1230            1 :             .await
    1231            1 :             .unwrap();
    1232            1 : 
    1233            1 :         let ar_hdr = AppendRequestHeader {
    1234            1 :             term: 1,
    1235            1 :             term_start_lsn: Lsn(3),
    1236            1 :             begin_lsn: Lsn(1),
    1237            1 :             end_lsn: Lsn(2),
    1238            1 :             commit_lsn: Lsn(0),
    1239            1 :             truncate_lsn: Lsn(0),
    1240            1 :             proposer_uuid: [0; 16],
    1241            1 :         };
    1242            1 :         let append_request = AppendRequest {
    1243            1 :             h: ar_hdr.clone(),
    1244            1 :             wal_data: Bytes::from_static(b"b"),
    1245            1 :         };
    1246            1 : 
    1247            1 :         // do write ending at 2, it should be ok
    1248            1 :         sk.process_msg(&ProposerAcceptorMessage::AppendRequest(append_request))
    1249            1 :             .await
    1250            1 :             .unwrap();
    1251            1 :         let mut ar_hrd2 = ar_hdr.clone();
    1252            1 :         ar_hrd2.begin_lsn = Lsn(4);
    1253            1 :         ar_hrd2.end_lsn = Lsn(5);
    1254            1 :         let append_request = AppendRequest {
    1255            1 :             h: ar_hdr,
    1256            1 :             wal_data: Bytes::from_static(b"b"),
    1257            1 :         };
    1258            1 :         // and now starting at 4, it must fail
    1259            1 :         sk.process_msg(&ProposerAcceptorMessage::AppendRequest(append_request))
    1260            1 :             .await
    1261            1 :             .unwrap_err();
    1262            1 :     }
    1263              : 
    1264              :     #[test]
    1265            1 :     fn test_find_highest_common_point_none() {
    1266            1 :         let prop_th = TermHistory(vec![(0, Lsn(1)).into()]);
    1267            1 :         let sk_th = TermHistory(vec![(1, Lsn(1)).into(), (2, Lsn(2)).into()]);
    1268            1 :         assert_eq!(
    1269            1 :             TermHistory::find_highest_common_point(&prop_th, &sk_th, Lsn(3),),
    1270            1 :             None
    1271            1 :         );
    1272            1 :     }
    1273              : 
    1274              :     #[test]
    1275            1 :     fn test_find_highest_common_point_middle() {
    1276            1 :         let prop_th = TermHistory(vec![
    1277            1 :             (1, Lsn(10)).into(),
    1278            1 :             (2, Lsn(20)).into(),
    1279            1 :             (4, Lsn(40)).into(),
    1280            1 :         ]);
    1281            1 :         let sk_th = TermHistory(vec![
    1282            1 :             (1, Lsn(10)).into(),
    1283            1 :             (2, Lsn(20)).into(),
    1284            1 :             (3, Lsn(30)).into(), // sk ends last common term 2 at 30
    1285            1 :         ]);
    1286            1 :         assert_eq!(
    1287            1 :             TermHistory::find_highest_common_point(&prop_th, &sk_th, Lsn(40),),
    1288            1 :             Some(TermLsn {
    1289            1 :                 term: 2,
    1290            1 :                 lsn: Lsn(30),
    1291            1 :             })
    1292            1 :         );
    1293            1 :     }
    1294              : 
    1295              :     #[test]
    1296            1 :     fn test_find_highest_common_point_sk_end() {
    1297            1 :         let prop_th = TermHistory(vec![
    1298            1 :             (1, Lsn(10)).into(),
    1299            1 :             (2, Lsn(20)).into(), // last common term 2, sk will end it at 32 sk_end_lsn
    1300            1 :             (4, Lsn(40)).into(),
    1301            1 :         ]);
    1302            1 :         let sk_th = TermHistory(vec![(1, Lsn(10)).into(), (2, Lsn(20)).into()]);
    1303            1 :         assert_eq!(
    1304            1 :             TermHistory::find_highest_common_point(&prop_th, &sk_th, Lsn(32),),
    1305            1 :             Some(TermLsn {
    1306            1 :                 term: 2,
    1307            1 :                 lsn: Lsn(32),
    1308            1 :             })
    1309            1 :         );
    1310            1 :     }
    1311              : 
    1312              :     #[test]
    1313            1 :     fn test_find_highest_common_point_walprop() {
    1314            1 :         let prop_th = TermHistory(vec![(1, Lsn(10)).into(), (2, Lsn(20)).into()]);
    1315            1 :         let sk_th = TermHistory(vec![(1, Lsn(10)).into(), (2, Lsn(20)).into()]);
    1316            1 :         assert_eq!(
    1317            1 :             TermHistory::find_highest_common_point(&prop_th, &sk_th, Lsn(32),),
    1318            1 :             Some(TermLsn {
    1319            1 :                 term: 2,
    1320            1 :                 lsn: Lsn(32),
    1321            1 :             })
    1322            1 :         );
    1323            1 :     }
    1324              : 
    1325              :     #[test]
    1326            1 :     fn test_sk_state_bincode_serde_roundtrip() {
    1327              :         use utils::Hex;
    1328            1 :         let tenant_id = TenantId::from_str("cf0480929707ee75372337efaa5ecf96").unwrap();
    1329            1 :         let timeline_id = TimelineId::from_str("112ded66422aa5e953e5440fa5427ac4").unwrap();
    1330            1 :         let state = TimelinePersistentState {
    1331            1 :             tenant_id,
    1332            1 :             timeline_id,
    1333            1 :             acceptor_state: AcceptorState {
    1334            1 :                 term: 42,
    1335            1 :                 term_history: TermHistory(vec![TermLsn {
    1336            1 :                     lsn: Lsn(0x1),
    1337            1 :                     term: 41,
    1338            1 :                 }]),
    1339            1 :             },
    1340            1 :             server: ServerInfo {
    1341            1 :                 pg_version: 14,
    1342            1 :                 system_id: 0x1234567887654321,
    1343            1 :                 wal_seg_size: 0x12345678,
    1344            1 :             },
    1345            1 :             proposer_uuid: {
    1346            1 :                 let mut arr = timeline_id.as_arr();
    1347            1 :                 arr.reverse();
    1348            1 :                 arr
    1349            1 :             },
    1350            1 :             timeline_start_lsn: Lsn(0x12345600),
    1351            1 :             local_start_lsn: Lsn(0x12),
    1352            1 :             commit_lsn: Lsn(1234567800),
    1353            1 :             backup_lsn: Lsn(1234567300),
    1354            1 :             peer_horizon_lsn: Lsn(9999999),
    1355            1 :             remote_consistent_lsn: Lsn(1234560000),
    1356            1 :             peers: PersistedPeers(vec![(
    1357            1 :                 NodeId(1),
    1358            1 :                 PersistedPeerInfo {
    1359            1 :                     backup_lsn: Lsn(1234567000),
    1360            1 :                     term: 42,
    1361            1 :                     flush_lsn: Lsn(1234567800 - 8),
    1362            1 :                     commit_lsn: Lsn(1234567600),
    1363            1 :                 },
    1364            1 :             )]),
    1365            1 :             partial_backup: crate::wal_backup_partial::State::default(),
    1366            1 :             eviction_state: EvictionState::Present,
    1367            1 :         };
    1368            1 : 
    1369            1 :         let ser = state.ser().unwrap();
    1370            1 : 
    1371            1 :         #[rustfmt::skip]
    1372            1 :         let expected = [
    1373            1 :             // tenant_id as length prefixed hex
    1374            1 :             0x20, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1375            1 :             0x63, 0x66, 0x30, 0x34, 0x38, 0x30, 0x39, 0x32, 0x39, 0x37, 0x30, 0x37, 0x65, 0x65, 0x37, 0x35, 0x33, 0x37, 0x32, 0x33, 0x33, 0x37, 0x65, 0x66, 0x61, 0x61, 0x35, 0x65, 0x63, 0x66, 0x39, 0x36,
    1376            1 :             // timeline_id as length prefixed hex
    1377            1 :             0x20, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1378            1 :             0x31, 0x31, 0x32, 0x64, 0x65, 0x64, 0x36, 0x36, 0x34, 0x32, 0x32, 0x61, 0x61, 0x35, 0x65, 0x39, 0x35, 0x33, 0x65, 0x35, 0x34, 0x34, 0x30, 0x66, 0x61, 0x35, 0x34, 0x32, 0x37, 0x61, 0x63, 0x34,
    1379            1 :             // term
    1380            1 :             0x2a, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1381            1 :             // length prefix
    1382            1 :             0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1383            1 :             // unsure why this order is swapped
    1384            1 :             0x29, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1385            1 :             0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1386            1 :             // pg_version
    1387            1 :             0x0e, 0x00, 0x00, 0x00,
    1388            1 :             // systemid
    1389            1 :             0x21, 0x43, 0x65, 0x87, 0x78, 0x56, 0x34, 0x12,
    1390            1 :             // wal_seg_size
    1391            1 :             0x78, 0x56, 0x34, 0x12,
    1392            1 :             // pguuid as length prefixed hex
    1393            1 :             0x20, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1394            1 :             0x63, 0x34, 0x37, 0x61, 0x34, 0x32, 0x61, 0x35, 0x30, 0x66, 0x34, 0x34, 0x65, 0x35, 0x35, 0x33, 0x65, 0x39, 0x61, 0x35, 0x32, 0x61, 0x34, 0x32, 0x36, 0x36, 0x65, 0x64, 0x32, 0x64, 0x31, 0x31,
    1395            1 : 
    1396            1 :             // timeline_start_lsn
    1397            1 :             0x00, 0x56, 0x34, 0x12, 0x00, 0x00, 0x00, 0x00,
    1398            1 :             0x12, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1399            1 :             0x78, 0x02, 0x96, 0x49, 0x00, 0x00, 0x00, 0x00,
    1400            1 :             0x84, 0x00, 0x96, 0x49, 0x00, 0x00, 0x00, 0x00,
    1401            1 :             0x7f, 0x96, 0x98, 0x00, 0x00, 0x00, 0x00, 0x00,
    1402            1 :             0x00, 0xe4, 0x95, 0x49, 0x00, 0x00, 0x00, 0x00,
    1403            1 :             // length prefix for persistentpeers
    1404            1 :             0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1405            1 :             // nodeid
    1406            1 :             0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1407            1 :             // backuplsn
    1408            1 :             0x58, 0xff, 0x95, 0x49, 0x00, 0x00, 0x00, 0x00,
    1409            1 :             0x2a, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1410            1 :             0x70, 0x02, 0x96, 0x49, 0x00, 0x00, 0x00, 0x00,
    1411            1 :             0xb0, 0x01, 0x96, 0x49, 0x00, 0x00, 0x00, 0x00,
    1412            1 :             // partial_backup
    1413            1 :             0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1414            1 :             // eviction_state
    1415            1 :             0x00, 0x00, 0x00, 0x00,
    1416            1 :         ];
    1417            1 : 
    1418            1 :         assert_eq!(Hex(&ser), Hex(&expected));
    1419              : 
    1420            1 :         let deser = TimelinePersistentState::des(&ser).unwrap();
    1421            1 : 
    1422            1 :         assert_eq!(deser, state);
    1423            1 :     }
    1424              : }
        

Generated by: LCOV version 2.1-beta