LCOV - code coverage report
Current view: top level - safekeeper/src - safekeeper.rs (source / functions) Coverage Total Hit
Test: 3eba1babe267649f8cebefc91c236589db030548.info Lines: 85.0 % 912 775
Test Date: 2024-11-22 12:36:12 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         1456 :     pub fn empty() -> TermHistory {
      59         1456 :         TermHistory(Vec::new())
      60         1456 :     }
      61              : 
      62              :     // Parse TermHistory as n_entries followed by TermLsn pairs
      63          552 :     pub fn from_bytes(bytes: &mut Bytes) -> Result<TermHistory> {
      64          552 :         if bytes.remaining() < 4 {
      65            0 :             bail!("TermHistory misses len");
      66          552 :         }
      67          552 :         let n_entries = bytes.get_u32_le();
      68          552 :         let mut res = Vec::with_capacity(n_entries as usize);
      69          552 :         for _ in 0..n_entries {
      70         3041 :             if bytes.remaining() < 16 {
      71            0 :                 bail!("TermHistory is incomplete");
      72         3041 :             }
      73         3041 :             res.push(TermLsn {
      74         3041 :                 term: bytes.get_u64_le(),
      75         3041 :                 lsn: bytes.get_u64_le().into(),
      76         3041 :             })
      77              :         }
      78          552 :         Ok(TermHistory(res))
      79          552 :     }
      80              : 
      81              :     /// Return copy of self with switches happening strictly after up_to
      82              :     /// truncated.
      83         3478 :     pub fn up_to(&self, up_to: Lsn) -> TermHistory {
      84         3478 :         let mut res = Vec::with_capacity(self.0.len());
      85        12226 :         for e in &self.0 {
      86         8759 :             if e.lsn > up_to {
      87           11 :                 break;
      88         8748 :             }
      89         8748 :             res.push(*e);
      90              :         }
      91         3478 :         TermHistory(res)
      92         3478 :     }
      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          558 :     pub fn find_highest_common_point(
      99          558 :         prop_th: &TermHistory,
     100          558 :         sk_th: &TermHistory,
     101          558 :         sk_wal_end: Lsn,
     102          558 :     ) -> Option<TermLsn> {
     103          558 :         let (prop_th, sk_th) = (&prop_th.0, &sk_th.0); // avoid .0 below
     104              : 
     105          558 :         if let Some(sk_th_last) = sk_th.last() {
     106          414 :             assert!(
     107          414 :                 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          144 :         }
     113              : 
     114              :         // find last common term, if any...
     115          558 :         let mut last_common_idx = None;
     116         2430 :         for i in 0..min(sk_th.len(), prop_th.len()) {
     117         2430 :             if prop_th[i].term != sk_th[i].term {
     118            6 :                 break;
     119         2424 :             }
     120         2424 :             // If term is the same, LSN must be equal as well.
     121         2424 :             assert!(
     122         2424 :                 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         2424 :             last_common_idx = Some(i);
     129              :         }
     130          558 :         let last_common_idx = match last_common_idx {
     131          145 :             None => return None, // no common point
     132          413 :             Some(lci) => lci,
     133          413 :         };
     134          413 :         // Now find where it ends at both prop and sk and take min. End of
     135          413 :         // (common) term is the start of the next except it is the last one;
     136          413 :         // there it is flush_lsn in case of safekeeper or, in case of proposer
     137          413 :         // +infinity, so we just take flush_lsn then.
     138          413 :         if last_common_idx == prop_th.len() - 1 {
     139           25 :             Some(TermLsn {
     140           25 :                 term: prop_th[last_common_idx].term,
     141           25 :                 lsn: sk_wal_end,
     142           25 :             })
     143              :         } else {
     144          388 :             let prop_common_term_end = prop_th[last_common_idx + 1].lsn;
     145          388 :             let sk_common_term_end = if last_common_idx + 1 < sk_th.len() {
     146            5 :                 sk_th[last_common_idx + 1].lsn
     147              :             } else {
     148          383 :                 sk_wal_end
     149              :             };
     150          388 :             Some(TermLsn {
     151          388 :                 term: prop_th[last_common_idx].term,
     152          388 :                 lsn: min(prop_common_term_end, sk_common_term_end),
     153          388 :             })
     154              :         }
     155          558 :     }
     156              : }
     157              : 
     158              : /// Display only latest entries for Debug.
     159              : impl fmt::Debug for TermHistory {
     160          344 :     fn fmt(&self, fmt: &mut fmt::Formatter) -> fmt::Result {
     161          344 :         let n_printed = 20;
     162          344 :         write!(
     163          344 :             fmt,
     164          344 :             "{}{:?}",
     165          344 :             if self.0.len() > n_printed { "... " } else { "" },
     166          344 :             self.0
     167          344 :                 .iter()
     168          344 :                 .rev()
     169          344 :                 .take(n_printed)
     170         1272 :                 .map(|&e| (e.term, e.lsn)) // omit TermSwitchEntry
     171          344 :                 .collect::<Vec<_>>()
     172          344 :         )
     173          344 :     }
     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        20345 : #[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         2879 : #[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         2335 : #[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        26111 :     pub fn parse(msg_bytes: Bytes) -> Result<ProposerAcceptorMessage> {
     367        26111 :         // xxx using Reader is inefficient but easy to work with bincode
     368        26111 :         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        26111 :         let tag = stream.read_u64::<LittleEndian>()? as u8 as char;
     371        26111 :         match tag {
     372              :             'g' => {
     373        20345 :                 let msg = ProposerGreeting::des_from(&mut stream)?;
     374        20345 :                 Ok(ProposerAcceptorMessage::Greeting(msg))
     375              :             }
     376              :             'v' => {
     377         2879 :                 let msg = VoteRequest::des_from(&mut stream)?;
     378         2879 :                 Ok(ProposerAcceptorMessage::VoteRequest(msg))
     379              :             }
     380              :             'e' => {
     381          552 :                 let mut msg_bytes = stream.into_inner();
     382          552 :                 if msg_bytes.remaining() < 16 {
     383            0 :                     bail!("ProposerElected message is not complete");
     384          552 :                 }
     385          552 :                 let term = msg_bytes.get_u64_le();
     386          552 :                 let start_streaming_at = msg_bytes.get_u64_le().into();
     387          552 :                 let term_history = TermHistory::from_bytes(&mut msg_bytes)?;
     388          552 :                 if msg_bytes.remaining() < 8 {
     389            0 :                     bail!("ProposerElected message is not complete");
     390          552 :                 }
     391          552 :                 let timeline_start_lsn = msg_bytes.get_u64_le().into();
     392          552 :                 let msg = ProposerElected {
     393          552 :                     term,
     394          552 :                     start_streaming_at,
     395          552 :                     timeline_start_lsn,
     396          552 :                     term_history,
     397          552 :                 };
     398          552 :                 Ok(ProposerAcceptorMessage::Elected(msg))
     399              :             }
     400              :             'a' => {
     401              :                 // read header followed by wal data
     402         2335 :                 let hdr = AppendRequestHeader::des_from(&mut stream)?;
     403         2335 :                 let rec_size = hdr
     404         2335 :                     .end_lsn
     405         2335 :                     .checked_sub(hdr.begin_lsn)
     406         2335 :                     .context("begin_lsn > end_lsn in AppendRequest")?
     407              :                     .0 as usize;
     408         2335 :                 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         2335 :                 }
     414         2335 : 
     415         2335 :                 let mut wal_data_vec: Vec<u8> = vec![0; rec_size];
     416         2335 :                 stream.read_exact(&mut wal_data_vec)?;
     417         2335 :                 let wal_data = Bytes::from(wal_data_vec);
     418         2335 :                 let msg = AppendRequest { h: hdr, wal_data };
     419         2335 : 
     420         2335 :                 Ok(ProposerAcceptorMessage::AppendRequest(msg))
     421              :             }
     422            0 :             _ => bail!("unknown proposer-acceptor message tag: {}", tag),
     423              :         }
     424        26111 :     }
     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        25162 :     pub fn serialize(&self, buf: &mut BytesMut) -> Result<()> {
     502        25162 :         match self {
     503        20345 :             AcceptorProposerMessage::Greeting(msg) => {
     504        20345 :                 buf.put_u64_le('g' as u64);
     505        20345 :                 buf.put_u64_le(msg.term);
     506        20345 :                 buf.put_u64_le(msg.node_id.0);
     507        20345 :             }
     508         2879 :             AcceptorProposerMessage::VoteResponse(msg) => {
     509         2879 :                 buf.put_u64_le('v' as u64);
     510         2879 :                 buf.put_u64_le(msg.term);
     511         2879 :                 buf.put_u64_le(msg.vote_given);
     512         2879 :                 buf.put_u64_le(msg.flush_lsn.into());
     513         2879 :                 buf.put_u64_le(msg.truncate_lsn.into());
     514         2879 :                 buf.put_u32_le(msg.term_history.0.len() as u32);
     515         8971 :                 for e in &msg.term_history.0 {
     516         6092 :                     buf.put_u64_le(e.term);
     517         6092 :                     buf.put_u64_le(e.lsn.into());
     518         6092 :                 }
     519         2879 :                 buf.put_u64_le(msg.timeline_start_lsn.into());
     520              :             }
     521         1938 :             AcceptorProposerMessage::AppendResponse(msg) => {
     522         1938 :                 buf.put_u64_le('a' as u64);
     523         1938 :                 buf.put_u64_le(msg.term);
     524         1938 :                 buf.put_u64_le(msg.flush_lsn.into());
     525         1938 :                 buf.put_u64_le(msg.commit_lsn.into());
     526         1938 :                 buf.put_i64_le(msg.hs_feedback.ts);
     527         1938 :                 buf.put_u64_le(msg.hs_feedback.xmin);
     528         1938 :                 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         1938 :                 if let Some(ref msg) = msg.pageserver_feedback {
     533            0 :                     msg.serialize(buf);
     534         1938 :                 }
     535              :             }
     536              :         }
     537              : 
     538        25162 :         Ok(())
     539        25162 :     }
     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         9115 :     pub fn new(
     568         9115 :         state: TimelineState<CTRL>,
     569         9115 :         wal_store: WAL,
     570         9115 :         node_id: NodeId,
     571         9115 :     ) -> Result<SafeKeeper<CTRL, WAL>> {
     572         9115 :         if state.tenant_id == TenantId::from([0u8; 16])
     573         9115 :             || 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         9115 :         }
     581         9115 : 
     582         9115 :         Ok(SafeKeeper {
     583         9115 :             term_start_lsn: Lsn(0),
     584         9115 :             state,
     585         9115 :             wal_store,
     586         9115 :             node_id,
     587         9115 :         })
     588         9115 :     }
     589              : 
     590              :     /// Get history of term switches for the available WAL
     591         3435 :     fn get_term_history(&self) -> TermHistory {
     592         3435 :         self.state
     593         3435 :             .acceptor_state
     594         3435 :             .term_history
     595         3435 :             .up_to(self.flush_lsn())
     596         3435 :     }
     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        12630 :     pub fn flush_lsn(&self) -> Lsn {
     606        12630 :         max(self.wal_store.flush_lsn(), self.state.timeline_start_lsn)
     607        12630 :     }
     608              : 
     609              :     /// Process message from proposer and possibly form reply. Concurrent
     610              :     /// callers must exclude each other.
     611        28057 :     pub async fn process_msg(
     612        28057 :         &mut self,
     613        28057 :         msg: &ProposerAcceptorMessage,
     614        28057 :     ) -> Result<Option<AcceptorProposerMessage>> {
     615        28057 :         match msg {
     616        20345 :             ProposerAcceptorMessage::Greeting(msg) => self.handle_greeting(msg).await,
     617         2881 :             ProposerAcceptorMessage::VoteRequest(msg) => self.handle_vote_request(msg).await,
     618          554 :             ProposerAcceptorMessage::Elected(msg) => self.handle_elected(msg).await,
     619            4 :             ProposerAcceptorMessage::AppendRequest(msg) => {
     620            4 :                 self.handle_append_request(msg, true).await
     621              :             }
     622         2335 :             ProposerAcceptorMessage::NoFlushAppendRequest(msg) => {
     623         2335 :                 self.handle_append_request(msg, false).await
     624              :             }
     625         1938 :             ProposerAcceptorMessage::FlushWAL => self.handle_flush().await,
     626              :         }
     627        28057 :     }
     628              : 
     629              :     /// Handle initial message from proposer: check its sanity and send my
     630              :     /// current term.
     631        20345 :     async fn handle_greeting(
     632        20345 :         &mut self,
     633        20345 :         msg: &ProposerGreeting,
     634        20345 :     ) -> Result<Option<AcceptorProposerMessage>> {
     635        20345 :         // Check protocol compatibility
     636        20345 :         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        20345 :         }
     643        20345 :         /* Postgres major version mismatch is treated as fatal error
     644        20345 :          * because safekeepers parse WAL headers and the format
     645        20345 :          * may change between versions.
     646        20345 :          */
     647        20345 :         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        20345 :         }
     656        20345 : 
     657        20345 :         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        20345 :         }
     664        20345 :         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        20345 :         }
     671        20345 :         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        20345 :         }
     678        20345 : 
     679        20345 :         // system_id will be updated on mismatch
     680        20345 :         // sync-safekeepers doesn't know sysid and sends 0, ignore it
     681        20345 :         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        20345 :         }
     696              : 
     697        20345 :         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        20345 :         Ok(Some(AcceptorProposerMessage::Greeting(AcceptorGreeting {
     703        20345 :             term: self.state.acceptor_state.term,
     704        20345 :             node_id: self.node_id,
     705        20345 :         })))
     706        20345 :     }
     707              : 
     708              :     /// Give vote for the given term, if we haven't done that previously.
     709         2881 :     async fn handle_vote_request(
     710         2881 :         &mut self,
     711         2881 :         msg: &VoteRequest,
     712         2881 :     ) -> Result<Option<AcceptorProposerMessage>> {
     713         2881 :         // Once voted, we won't accept data from older proposers; flush
     714         2881 :         // everything we've already received so that new proposer starts
     715         2881 :         // streaming at end of our WAL, without overlap. Currently we truncate
     716         2881 :         // WAL at streaming point, so this avoids truncating already committed
     717         2881 :         // WAL.
     718         2881 :         //
     719         2881 :         // TODO: it would be smoother to not truncate committed piece at
     720         2881 :         // handle_elected instead. Currently not a big deal, as proposer is the
     721         2881 :         // only source of WAL; with peer2peer recovery it would be more
     722         2881 :         // important.
     723         2881 :         self.wal_store.flush_wal().await?;
     724              :         // initialize with refusal
     725         2881 :         let mut resp = VoteResponse {
     726         2881 :             term: self.state.acceptor_state.term,
     727         2881 :             vote_given: false as u64,
     728         2881 :             flush_lsn: self.flush_lsn(),
     729         2881 :             truncate_lsn: self.state.inmem.peer_horizon_lsn,
     730         2881 :             term_history: self.get_term_history(),
     731         2881 :             timeline_start_lsn: self.state.timeline_start_lsn,
     732         2881 :         };
     733         2881 :         if self.state.acceptor_state.term < msg.term {
     734         2741 :             let mut state = self.state.start_change();
     735         2741 :             state.acceptor_state.term = msg.term;
     736         2741 :             // persist vote before sending it out
     737         2741 :             self.state.finish_change(&state).await?;
     738              : 
     739         2741 :             resp.term = self.state.acceptor_state.term;
     740         2741 :             resp.vote_given = true as u64;
     741          140 :         }
     742         2881 :         info!("processed VoteRequest for term {}: {:?}", msg.term, &resp);
     743         2881 :         Ok(Some(AcceptorProposerMessage::VoteResponse(resp)))
     744         2881 :     }
     745              : 
     746              :     /// Form AppendResponse from current state.
     747         1941 :     fn append_response(&self) -> AppendResponse {
     748         1941 :         let ar = AppendResponse {
     749         1941 :             term: self.state.acceptor_state.term,
     750         1941 :             flush_lsn: self.flush_lsn(),
     751         1941 :             commit_lsn: self.state.commit_lsn,
     752         1941 :             // will be filled by the upper code to avoid bothering safekeeper
     753         1941 :             hs_feedback: HotStandbyFeedback::empty(),
     754         1941 :             pageserver_feedback: None,
     755         1941 :         };
     756         1941 :         trace!("formed AppendResponse {:?}", ar);
     757         1941 :         ar
     758         1941 :     }
     759              : 
     760          554 :     async fn handle_elected(
     761          554 :         &mut self,
     762          554 :         msg: &ProposerElected,
     763          554 :     ) -> Result<Option<AcceptorProposerMessage>> {
     764          554 :         let _timer = MISC_OPERATION_SECONDS
     765          554 :             .with_label_values(&["handle_elected"])
     766          554 :             .start_timer();
     767          554 : 
     768          554 :         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          554 :         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          552 :         }
     780              : 
     781              :         // If our term is higher, ignore the message (next feedback will inform the compute)
     782          554 :         if self.state.acceptor_state.term > msg.term {
     783            0 :             return Ok(None);
     784          554 :         }
     785          554 : 
     786          554 :         // Before truncating WAL check-cross the check divergence point received
     787          554 :         // from the walproposer.
     788          554 :         let sk_th = self.get_term_history();
     789          554 :         let last_common_point = match TermHistory::find_highest_common_point(
     790          554 :             &msg.term_history,
     791          554 :             &sk_th,
     792          554 :             self.flush_lsn(),
     793          554 :         ) {
     794              :             // No common point. Expect streaming from the beginning of the
     795              :             // history like walproposer while we don't have proper init.
     796          144 :             None => *msg.term_history.0.first().ok_or(anyhow::anyhow!(
     797          144 :                 "empty walproposer term history {:?}",
     798          144 :                 msg.term_history
     799          144 :             ))?,
     800          410 :             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          554 :         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          554 :         }
     816          554 : 
     817          554 :         // We are also expected to never attempt to truncate committed data.
     818          554 :         assert!(
     819          554 :             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          554 :         if self.wal_store.flush_lsn() == Lsn::INVALID {
     832          144 :             self.wal_store
     833          144 :                 .initialize_first_segment(msg.start_streaming_at)
     834            0 :                 .await?;
     835          410 :         }
     836              : 
     837              :         // truncate wal, update the LSNs
     838          554 :         self.wal_store.truncate_wal(msg.start_streaming_at).await?;
     839              : 
     840              :         // and now adopt term history from proposer
     841              :         {
     842          554 :             let mut state = self.state.start_change();
     843          554 : 
     844          554 :             // Here we learn initial LSN for the first time, set fields
     845          554 :             // interested in that.
     846          554 : 
     847          554 :             if state.timeline_start_lsn == Lsn(0) {
     848              :                 // Remember point where WAL begins globally.
     849          144 :                 state.timeline_start_lsn = msg.timeline_start_lsn;
     850          144 :                 info!(
     851            0 :                     "setting timeline_start_lsn to {:?}",
     852              :                     state.timeline_start_lsn
     853              :                 );
     854          410 :             }
     855          554 :             if state.peer_horizon_lsn == Lsn(0) {
     856          144 :                 // Update peer_horizon_lsn as soon as we know where timeline starts.
     857          144 :                 // It means that peer_horizon_lsn cannot be zero after we know timeline_start_lsn.
     858          144 :                 state.peer_horizon_lsn = msg.timeline_start_lsn;
     859          410 :             }
     860          554 :             if state.local_start_lsn == Lsn(0) {
     861          144 :                 state.local_start_lsn = msg.start_streaming_at;
     862          144 :                 info!("setting local_start_lsn to {:?}", state.local_start_lsn);
     863          410 :             }
     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          554 :             state.commit_lsn = max(state.commit_lsn, state.timeline_start_lsn);
     872          554 : 
     873          554 :             // Initializing backup_lsn is useful to avoid making backup think it should upload 0 segment.
     874          554 :             state.backup_lsn = max(state.backup_lsn, state.timeline_start_lsn);
     875          554 :             // similar for remote_consistent_lsn
     876          554 :             state.remote_consistent_lsn =
     877          554 :                 max(state.remote_consistent_lsn, state.timeline_start_lsn);
     878          554 : 
     879          554 :             state.acceptor_state.term_history = msg.term_history.clone();
     880          554 :             self.state.finish_change(&state).await?;
     881              :         }
     882              : 
     883          554 :         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          554 :         self.term_start_lsn = match msg.term_history.0.last() {
     889            0 :             None => bail!("proposer elected with empty term history"),
     890          554 :             Some(term_lsn_start) => term_lsn_start.lsn,
     891          554 :         };
     892          554 : 
     893          554 :         Ok(None)
     894          554 :     }
     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         1400 :     async fn update_commit_lsn(&mut self, mut candidate: Lsn) -> Result<()> {
     901         1400 :         // Both peers and walproposer communicate this value, we might already
     902         1400 :         // have a fresher (higher) version.
     903         1400 :         candidate = max(candidate, self.state.inmem.commit_lsn);
     904         1400 :         let commit_lsn = min(candidate, self.flush_lsn());
     905         1400 :         assert!(
     906         1400 :             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         1400 :         self.state.inmem.commit_lsn = commit_lsn;
     913         1400 : 
     914         1400 :         // If new commit_lsn reached term switch, force sync of control
     915         1400 :         // file: walproposer in sync mode is very interested when this
     916         1400 :         // happens. Note: this is for sync-safekeepers mode only, as
     917         1400 :         // otherwise commit_lsn might jump over term_start_lsn.
     918         1400 :         if commit_lsn >= self.term_start_lsn && self.state.commit_lsn < self.term_start_lsn {
     919           58 :             self.state.flush().await?;
     920         1342 :         }
     921              : 
     922         1400 :         Ok(())
     923         1400 :     }
     924              : 
     925              :     /// Handle request to append WAL.
     926              :     #[allow(clippy::comparison_chain)]
     927         2339 :     async fn handle_append_request(
     928         2339 :         &mut self,
     929         2339 :         msg: &AppendRequest,
     930         2339 :         require_flush: bool,
     931         2339 :     ) -> Result<Option<AcceptorProposerMessage>> {
     932         2339 :         if self.state.acceptor_state.term < msg.h.term {
     933            0 :             bail!("got AppendRequest before ProposerElected");
     934         2339 :         }
     935         2339 : 
     936         2339 :         // If our term is higher, immediately refuse the message.
     937         2339 :         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         2339 :         }
     941         2339 : 
     942         2339 :         // Disallow any non-sequential writes, which can result in gaps or
     943         2339 :         // overwrites. If we need to move the pointer, ProposerElected message
     944         2339 :         // should have truncated WAL first accordingly. Note that the first
     945         2339 :         // condition (WAL rewrite) is quite expected in real world; it happens
     946         2339 :         // when walproposer reconnects to safekeeper and writes some more data
     947         2339 :         // while first connection still gets some packets later. It might be
     948         2339 :         // better to not log this as error! above.
     949         2339 :         let write_lsn = self.wal_store.write_lsn();
     950         2339 :         let flush_lsn = self.wal_store.flush_lsn();
     951         2339 :         if write_lsn > msg.h.begin_lsn {
     952            1 :             bail!(
     953            1 :                 "append request rewrites WAL written before, write_lsn={}, msg lsn={}",
     954            1 :                 write_lsn,
     955            1 :                 msg.h.begin_lsn
     956            1 :             );
     957         2338 :         }
     958         2338 :         if write_lsn < msg.h.begin_lsn && write_lsn != Lsn(0) {
     959            0 :             bail!(
     960            0 :                 "append request creates gap in written WAL, write_lsn={}, msg lsn={}",
     961            0 :                 write_lsn,
     962            0 :                 msg.h.begin_lsn,
     963            0 :             );
     964         2338 :         }
     965         2338 : 
     966         2338 :         // Now we know that we are in the same term as the proposer,
     967         2338 :         // processing the message.
     968         2338 : 
     969         2338 :         self.state.inmem.proposer_uuid = msg.h.proposer_uuid;
     970         2338 : 
     971         2338 :         // do the job
     972         2338 :         if !msg.wal_data.is_empty() {
     973          630 :             self.wal_store
     974          630 :                 .write_wal(msg.h.begin_lsn, &msg.wal_data)
     975            0 :                 .await?;
     976         1708 :         }
     977              : 
     978              :         // flush wal to the disk, if required
     979         2338 :         if require_flush {
     980            3 :             self.wal_store.flush_wal().await?;
     981         2335 :         }
     982              : 
     983              :         // Update commit_lsn. It will be flushed to the control file regularly by the timeline
     984              :         // manager, off of the WAL ingest hot path.
     985         2338 :         if msg.h.commit_lsn != Lsn(0) {
     986         1400 :             self.update_commit_lsn(msg.h.commit_lsn).await?;
     987          938 :         }
     988              :         // Value calculated by walproposer can always lag:
     989              :         // - safekeepers can forget inmem value and send to proposer lower
     990              :         //   persisted one on restart;
     991              :         // - if we make safekeepers always send persistent value,
     992              :         //   any compute restart would pull it down.
     993              :         // Thus, take max before adopting.
     994         2338 :         self.state.inmem.peer_horizon_lsn =
     995         2338 :             max(self.state.inmem.peer_horizon_lsn, msg.h.truncate_lsn);
     996         2338 : 
     997         2338 :         trace!(
     998            0 :             "processed AppendRequest of len {}, begin_lsn={}, end_lsn={:?}, commit_lsn={:?}, truncate_lsn={:?}, flushed={:?}",
     999            0 :             msg.wal_data.len(),
    1000              :             msg.h.begin_lsn,
    1001              :             msg.h.end_lsn,
    1002              :             msg.h.commit_lsn,
    1003              :             msg.h.truncate_lsn,
    1004              :             require_flush,
    1005              :         );
    1006              : 
    1007              :         // If flush_lsn hasn't updated, AppendResponse is not very useful.
    1008              :         // This is the common case for !require_flush, but a flush can still
    1009              :         // happen on segment bounds.
    1010         2338 :         if !require_flush && flush_lsn == self.flush_lsn() {
    1011         2335 :             return Ok(None);
    1012            3 :         }
    1013            3 : 
    1014            3 :         let resp = self.append_response();
    1015            3 :         Ok(Some(AcceptorProposerMessage::AppendResponse(resp)))
    1016         2339 :     }
    1017              : 
    1018              :     /// Flush WAL to disk. Return AppendResponse with latest LSNs.
    1019         1938 :     async fn handle_flush(&mut self) -> Result<Option<AcceptorProposerMessage>> {
    1020         1938 :         self.wal_store.flush_wal().await?;
    1021         1938 :         Ok(Some(AcceptorProposerMessage::AppendResponse(
    1022         1938 :             self.append_response(),
    1023         1938 :         )))
    1024         1938 :     }
    1025              : 
    1026              :     /// Update commit_lsn from peer safekeeper data.
    1027            0 :     pub async fn record_safekeeper_info(&mut self, sk_info: &SafekeeperTimelineInfo) -> Result<()> {
    1028            0 :         if (Lsn(sk_info.commit_lsn) != Lsn::INVALID) && (sk_info.last_log_term != INVALID_TERM) {
    1029              :             // Note: the check is too restrictive, generally we can update local
    1030              :             // commit_lsn if our history matches (is part of) history of advanced
    1031              :             // commit_lsn provider.
    1032            0 :             if sk_info.last_log_term == self.get_last_log_term() {
    1033            0 :                 self.update_commit_lsn(Lsn(sk_info.commit_lsn)).await?;
    1034            0 :             }
    1035            0 :         }
    1036            0 :         Ok(())
    1037            0 :     }
    1038              : }
    1039              : 
    1040              : #[cfg(test)]
    1041              : mod tests {
    1042              :     use futures::future::BoxFuture;
    1043              :     use postgres_ffi::{XLogSegNo, WAL_SEGMENT_SIZE};
    1044              : 
    1045              :     use super::*;
    1046              :     use crate::state::{EvictionState, PersistedPeers, TimelinePersistentState};
    1047              :     use std::{ops::Deref, str::FromStr, time::Instant};
    1048              : 
    1049              :     // fake storage for tests
    1050              :     struct InMemoryState {
    1051              :         persisted_state: TimelinePersistentState,
    1052              :     }
    1053              : 
    1054              :     impl control_file::Storage for InMemoryState {
    1055            5 :         async fn persist(&mut self, s: &TimelinePersistentState) -> Result<()> {
    1056            5 :             self.persisted_state = s.clone();
    1057            5 :             Ok(())
    1058            5 :         }
    1059              : 
    1060            0 :         fn last_persist_at(&self) -> Instant {
    1061            0 :             Instant::now()
    1062            0 :         }
    1063              :     }
    1064              : 
    1065              :     impl Deref for InMemoryState {
    1066              :         type Target = TimelinePersistentState;
    1067              : 
    1068           83 :         fn deref(&self) -> &Self::Target {
    1069           83 :             &self.persisted_state
    1070           83 :         }
    1071              :     }
    1072              : 
    1073            3 :     fn test_sk_state() -> TimelinePersistentState {
    1074            3 :         let mut state = TimelinePersistentState::empty();
    1075            3 :         state.server.wal_seg_size = WAL_SEGMENT_SIZE as u32;
    1076            3 :         state.tenant_id = TenantId::from([1u8; 16]);
    1077            3 :         state.timeline_id = TimelineId::from([1u8; 16]);
    1078            3 :         state
    1079            3 :     }
    1080              : 
    1081              :     struct DummyWalStore {
    1082              :         lsn: Lsn,
    1083              :     }
    1084              : 
    1085              :     impl wal_storage::Storage for DummyWalStore {
    1086            4 :         fn write_lsn(&self) -> Lsn {
    1087            4 :             self.lsn
    1088            4 :         }
    1089              : 
    1090           19 :         fn flush_lsn(&self) -> Lsn {
    1091           19 :             self.lsn
    1092           19 :         }
    1093              : 
    1094            2 :         async fn initialize_first_segment(&mut self, _init_lsn: Lsn) -> Result<()> {
    1095            2 :             Ok(())
    1096            2 :         }
    1097              : 
    1098            3 :         async fn write_wal(&mut self, startpos: Lsn, buf: &[u8]) -> Result<()> {
    1099            3 :             self.lsn = startpos + buf.len() as u64;
    1100            3 :             Ok(())
    1101            3 :         }
    1102              : 
    1103            2 :         async fn truncate_wal(&mut self, end_pos: Lsn) -> Result<()> {
    1104            2 :             self.lsn = end_pos;
    1105            2 :             Ok(())
    1106            2 :         }
    1107              : 
    1108            5 :         async fn flush_wal(&mut self) -> Result<()> {
    1109            5 :             Ok(())
    1110            5 :         }
    1111              : 
    1112            0 :         fn remove_up_to(&self, _segno_up_to: XLogSegNo) -> BoxFuture<'static, anyhow::Result<()>> {
    1113            0 :             Box::pin(async { Ok(()) })
    1114            0 :         }
    1115              : 
    1116            0 :         fn get_metrics(&self) -> crate::metrics::WalStorageMetrics {
    1117            0 :             crate::metrics::WalStorageMetrics::default()
    1118            0 :         }
    1119              :     }
    1120              : 
    1121              :     #[tokio::test]
    1122            1 :     async fn test_voting() {
    1123            1 :         let storage = InMemoryState {
    1124            1 :             persisted_state: test_sk_state(),
    1125            1 :         };
    1126            1 :         let wal_store = DummyWalStore { lsn: Lsn(0) };
    1127            1 :         let mut sk = SafeKeeper::new(TimelineState::new(storage), wal_store, NodeId(0)).unwrap();
    1128            1 : 
    1129            1 :         // check voting for 1 is ok
    1130            1 :         let vote_request = ProposerAcceptorMessage::VoteRequest(VoteRequest { term: 1 });
    1131            1 :         let mut vote_resp = sk.process_msg(&vote_request).await;
    1132            1 :         match vote_resp.unwrap() {
    1133            1 :             Some(AcceptorProposerMessage::VoteResponse(resp)) => assert!(resp.vote_given != 0),
    1134            1 :             r => panic!("unexpected response: {:?}", r),
    1135            1 :         }
    1136            1 : 
    1137            1 :         // reboot...
    1138            1 :         let state = sk.state.deref().clone();
    1139            1 :         let storage = InMemoryState {
    1140            1 :             persisted_state: state,
    1141            1 :         };
    1142            1 : 
    1143            1 :         sk = SafeKeeper::new(TimelineState::new(storage), sk.wal_store, NodeId(0)).unwrap();
    1144            1 : 
    1145            1 :         // and ensure voting second time for 1 is not ok
    1146            1 :         vote_resp = sk.process_msg(&vote_request).await;
    1147            1 :         match vote_resp.unwrap() {
    1148            1 :             Some(AcceptorProposerMessage::VoteResponse(resp)) => assert!(resp.vote_given == 0),
    1149            1 :             r => panic!("unexpected response: {:?}", r),
    1150            1 :         }
    1151            1 :     }
    1152              : 
    1153              :     #[tokio::test]
    1154            1 :     async fn test_last_log_term_switch() {
    1155            1 :         let storage = InMemoryState {
    1156            1 :             persisted_state: test_sk_state(),
    1157            1 :         };
    1158            1 :         let wal_store = DummyWalStore { lsn: Lsn(0) };
    1159            1 : 
    1160            1 :         let mut sk = SafeKeeper::new(TimelineState::new(storage), wal_store, NodeId(0)).unwrap();
    1161            1 : 
    1162            1 :         let mut ar_hdr = AppendRequestHeader {
    1163            1 :             term: 2,
    1164            1 :             term_start_lsn: Lsn(3),
    1165            1 :             begin_lsn: Lsn(1),
    1166            1 :             end_lsn: Lsn(2),
    1167            1 :             commit_lsn: Lsn(0),
    1168            1 :             truncate_lsn: Lsn(0),
    1169            1 :             proposer_uuid: [0; 16],
    1170            1 :         };
    1171            1 :         let mut append_request = AppendRequest {
    1172            1 :             h: ar_hdr.clone(),
    1173            1 :             wal_data: Bytes::from_static(b"b"),
    1174            1 :         };
    1175            1 : 
    1176            1 :         let pem = ProposerElected {
    1177            1 :             term: 2,
    1178            1 :             start_streaming_at: Lsn(1),
    1179            1 :             term_history: TermHistory(vec![
    1180            1 :                 TermLsn {
    1181            1 :                     term: 1,
    1182            1 :                     lsn: Lsn(1),
    1183            1 :                 },
    1184            1 :                 TermLsn {
    1185            1 :                     term: 2,
    1186            1 :                     lsn: Lsn(3),
    1187            1 :                 },
    1188            1 :             ]),
    1189            1 :             timeline_start_lsn: Lsn(1),
    1190            1 :         };
    1191            1 :         sk.process_msg(&ProposerAcceptorMessage::Elected(pem))
    1192            1 :             .await
    1193            1 :             .unwrap();
    1194            1 : 
    1195            1 :         // check that AppendRequest before term_start_lsn doesn't switch last_log_term.
    1196            1 :         sk.process_msg(&ProposerAcceptorMessage::AppendRequest(append_request))
    1197            1 :             .await
    1198            1 :             .unwrap();
    1199            1 :         assert_eq!(sk.get_last_log_term(), 1);
    1200            1 : 
    1201            1 :         // but record at term_start_lsn does the switch
    1202            1 :         ar_hdr.begin_lsn = Lsn(2);
    1203            1 :         ar_hdr.end_lsn = Lsn(3);
    1204            1 :         append_request = AppendRequest {
    1205            1 :             h: ar_hdr,
    1206            1 :             wal_data: Bytes::from_static(b"b"),
    1207            1 :         };
    1208            1 :         sk.process_msg(&ProposerAcceptorMessage::AppendRequest(append_request))
    1209            1 :             .await
    1210            1 :             .unwrap();
    1211            1 :         assert_eq!(sk.get_last_log_term(), 2);
    1212            1 :     }
    1213              : 
    1214              :     #[tokio::test]
    1215            1 :     async fn test_non_consecutive_write() {
    1216            1 :         let storage = InMemoryState {
    1217            1 :             persisted_state: test_sk_state(),
    1218            1 :         };
    1219            1 :         let wal_store = DummyWalStore { lsn: Lsn(0) };
    1220            1 : 
    1221            1 :         let mut sk = SafeKeeper::new(TimelineState::new(storage), wal_store, NodeId(0)).unwrap();
    1222            1 : 
    1223            1 :         let pem = ProposerElected {
    1224            1 :             term: 1,
    1225            1 :             start_streaming_at: Lsn(1),
    1226            1 :             term_history: TermHistory(vec![TermLsn {
    1227            1 :                 term: 1,
    1228            1 :                 lsn: Lsn(1),
    1229            1 :             }]),
    1230            1 :             timeline_start_lsn: Lsn(1),
    1231            1 :         };
    1232            1 :         sk.process_msg(&ProposerAcceptorMessage::Elected(pem))
    1233            1 :             .await
    1234            1 :             .unwrap();
    1235            1 : 
    1236            1 :         let ar_hdr = AppendRequestHeader {
    1237            1 :             term: 1,
    1238            1 :             term_start_lsn: Lsn(3),
    1239            1 :             begin_lsn: Lsn(1),
    1240            1 :             end_lsn: Lsn(2),
    1241            1 :             commit_lsn: Lsn(0),
    1242            1 :             truncate_lsn: Lsn(0),
    1243            1 :             proposer_uuid: [0; 16],
    1244            1 :         };
    1245            1 :         let append_request = AppendRequest {
    1246            1 :             h: ar_hdr.clone(),
    1247            1 :             wal_data: Bytes::from_static(b"b"),
    1248            1 :         };
    1249            1 : 
    1250            1 :         // do write ending at 2, it should be ok
    1251            1 :         sk.process_msg(&ProposerAcceptorMessage::AppendRequest(append_request))
    1252            1 :             .await
    1253            1 :             .unwrap();
    1254            1 :         let mut ar_hrd2 = ar_hdr.clone();
    1255            1 :         ar_hrd2.begin_lsn = Lsn(4);
    1256            1 :         ar_hrd2.end_lsn = Lsn(5);
    1257            1 :         let append_request = AppendRequest {
    1258            1 :             h: ar_hdr,
    1259            1 :             wal_data: Bytes::from_static(b"b"),
    1260            1 :         };
    1261            1 :         // and now starting at 4, it must fail
    1262            1 :         sk.process_msg(&ProposerAcceptorMessage::AppendRequest(append_request))
    1263            1 :             .await
    1264            1 :             .unwrap_err();
    1265            1 :     }
    1266              : 
    1267              :     #[test]
    1268            1 :     fn test_find_highest_common_point_none() {
    1269            1 :         let prop_th = TermHistory(vec![(0, Lsn(1)).into()]);
    1270            1 :         let sk_th = TermHistory(vec![(1, Lsn(1)).into(), (2, Lsn(2)).into()]);
    1271            1 :         assert_eq!(
    1272            1 :             TermHistory::find_highest_common_point(&prop_th, &sk_th, Lsn(3),),
    1273            1 :             None
    1274            1 :         );
    1275            1 :     }
    1276              : 
    1277              :     #[test]
    1278            1 :     fn test_find_highest_common_point_middle() {
    1279            1 :         let prop_th = TermHistory(vec![
    1280            1 :             (1, Lsn(10)).into(),
    1281            1 :             (2, Lsn(20)).into(),
    1282            1 :             (4, Lsn(40)).into(),
    1283            1 :         ]);
    1284            1 :         let sk_th = TermHistory(vec![
    1285            1 :             (1, Lsn(10)).into(),
    1286            1 :             (2, Lsn(20)).into(),
    1287            1 :             (3, Lsn(30)).into(), // sk ends last common term 2 at 30
    1288            1 :         ]);
    1289            1 :         assert_eq!(
    1290            1 :             TermHistory::find_highest_common_point(&prop_th, &sk_th, Lsn(40),),
    1291            1 :             Some(TermLsn {
    1292            1 :                 term: 2,
    1293            1 :                 lsn: Lsn(30),
    1294            1 :             })
    1295            1 :         );
    1296            1 :     }
    1297              : 
    1298              :     #[test]
    1299            1 :     fn test_find_highest_common_point_sk_end() {
    1300            1 :         let prop_th = TermHistory(vec![
    1301            1 :             (1, Lsn(10)).into(),
    1302            1 :             (2, Lsn(20)).into(), // last common term 2, sk will end it at 32 sk_end_lsn
    1303            1 :             (4, Lsn(40)).into(),
    1304            1 :         ]);
    1305            1 :         let sk_th = TermHistory(vec![(1, Lsn(10)).into(), (2, Lsn(20)).into()]);
    1306            1 :         assert_eq!(
    1307            1 :             TermHistory::find_highest_common_point(&prop_th, &sk_th, Lsn(32),),
    1308            1 :             Some(TermLsn {
    1309            1 :                 term: 2,
    1310            1 :                 lsn: Lsn(32),
    1311            1 :             })
    1312            1 :         );
    1313            1 :     }
    1314              : 
    1315              :     #[test]
    1316            1 :     fn test_find_highest_common_point_walprop() {
    1317            1 :         let prop_th = TermHistory(vec![(1, Lsn(10)).into(), (2, Lsn(20)).into()]);
    1318            1 :         let sk_th = TermHistory(vec![(1, Lsn(10)).into(), (2, Lsn(20)).into()]);
    1319            1 :         assert_eq!(
    1320            1 :             TermHistory::find_highest_common_point(&prop_th, &sk_th, Lsn(32),),
    1321            1 :             Some(TermLsn {
    1322            1 :                 term: 2,
    1323            1 :                 lsn: Lsn(32),
    1324            1 :             })
    1325            1 :         );
    1326            1 :     }
    1327              : 
    1328              :     #[test]
    1329            1 :     fn test_sk_state_bincode_serde_roundtrip() {
    1330              :         use utils::Hex;
    1331            1 :         let tenant_id = TenantId::from_str("cf0480929707ee75372337efaa5ecf96").unwrap();
    1332            1 :         let timeline_id = TimelineId::from_str("112ded66422aa5e953e5440fa5427ac4").unwrap();
    1333            1 :         let state = TimelinePersistentState {
    1334            1 :             tenant_id,
    1335            1 :             timeline_id,
    1336            1 :             acceptor_state: AcceptorState {
    1337            1 :                 term: 42,
    1338            1 :                 term_history: TermHistory(vec![TermLsn {
    1339            1 :                     lsn: Lsn(0x1),
    1340            1 :                     term: 41,
    1341            1 :                 }]),
    1342            1 :             },
    1343            1 :             server: ServerInfo {
    1344            1 :                 pg_version: 14,
    1345            1 :                 system_id: 0x1234567887654321,
    1346            1 :                 wal_seg_size: 0x12345678,
    1347            1 :             },
    1348            1 :             proposer_uuid: {
    1349            1 :                 let mut arr = timeline_id.as_arr();
    1350            1 :                 arr.reverse();
    1351            1 :                 arr
    1352            1 :             },
    1353            1 :             timeline_start_lsn: Lsn(0x12345600),
    1354            1 :             local_start_lsn: Lsn(0x12),
    1355            1 :             commit_lsn: Lsn(1234567800),
    1356            1 :             backup_lsn: Lsn(1234567300),
    1357            1 :             peer_horizon_lsn: Lsn(9999999),
    1358            1 :             remote_consistent_lsn: Lsn(1234560000),
    1359            1 :             peers: PersistedPeers(vec![(
    1360            1 :                 NodeId(1),
    1361            1 :                 PersistedPeerInfo {
    1362            1 :                     backup_lsn: Lsn(1234567000),
    1363            1 :                     term: 42,
    1364            1 :                     flush_lsn: Lsn(1234567800 - 8),
    1365            1 :                     commit_lsn: Lsn(1234567600),
    1366            1 :                 },
    1367            1 :             )]),
    1368            1 :             partial_backup: crate::wal_backup_partial::State::default(),
    1369            1 :             eviction_state: EvictionState::Present,
    1370            1 :         };
    1371            1 : 
    1372            1 :         let ser = state.ser().unwrap();
    1373            1 : 
    1374            1 :         #[rustfmt::skip]
    1375            1 :         let expected = [
    1376            1 :             // tenant_id as length prefixed hex
    1377            1 :             0x20, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1378            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,
    1379            1 :             // timeline_id as length prefixed hex
    1380            1 :             0x20, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1381            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,
    1382            1 :             // term
    1383            1 :             0x2a, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1384            1 :             // length prefix
    1385            1 :             0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1386            1 :             // unsure why this order is swapped
    1387            1 :             0x29, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1388            1 :             0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1389            1 :             // pg_version
    1390            1 :             0x0e, 0x00, 0x00, 0x00,
    1391            1 :             // systemid
    1392            1 :             0x21, 0x43, 0x65, 0x87, 0x78, 0x56, 0x34, 0x12,
    1393            1 :             // wal_seg_size
    1394            1 :             0x78, 0x56, 0x34, 0x12,
    1395            1 :             // pguuid as length prefixed hex
    1396            1 :             0x20, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1397            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,
    1398            1 : 
    1399            1 :             // timeline_start_lsn
    1400            1 :             0x00, 0x56, 0x34, 0x12, 0x00, 0x00, 0x00, 0x00,
    1401            1 :             0x12, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1402            1 :             0x78, 0x02, 0x96, 0x49, 0x00, 0x00, 0x00, 0x00,
    1403            1 :             0x84, 0x00, 0x96, 0x49, 0x00, 0x00, 0x00, 0x00,
    1404            1 :             0x7f, 0x96, 0x98, 0x00, 0x00, 0x00, 0x00, 0x00,
    1405            1 :             0x00, 0xe4, 0x95, 0x49, 0x00, 0x00, 0x00, 0x00,
    1406            1 :             // length prefix for persistentpeers
    1407            1 :             0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1408            1 :             // nodeid
    1409            1 :             0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1410            1 :             // backuplsn
    1411            1 :             0x58, 0xff, 0x95, 0x49, 0x00, 0x00, 0x00, 0x00,
    1412            1 :             0x2a, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1413            1 :             0x70, 0x02, 0x96, 0x49, 0x00, 0x00, 0x00, 0x00,
    1414            1 :             0xb0, 0x01, 0x96, 0x49, 0x00, 0x00, 0x00, 0x00,
    1415            1 :             // partial_backup
    1416            1 :             0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,
    1417            1 :             // eviction_state
    1418            1 :             0x00, 0x00, 0x00, 0x00,
    1419            1 :         ];
    1420            1 : 
    1421            1 :         assert_eq!(Hex(&ser), Hex(&expected));
    1422              : 
    1423            1 :         let deser = TimelinePersistentState::des(&ser).unwrap();
    1424            1 : 
    1425            1 :         assert_eq!(deser, state);
    1426            1 :     }
    1427              : }
        

Generated by: LCOV version 2.1-beta