Line data Source code
1 : use desim::proto::SimEvent;
2 : use tracing::debug;
3 :
4 : #[derive(Debug, Clone, PartialEq, Eq)]
5 : enum NodeKind {
6 : Unknown,
7 : Safekeeper,
8 : WalProposer,
9 : }
10 :
11 : impl Default for NodeKind {
12 84651 : fn default() -> Self {
13 84651 : Self::Unknown
14 84651 : }
15 : }
16 :
17 : /// Simulation state of walproposer/safekeeper, derived from the simulation logs.
18 : #[derive(Clone, Debug, Default)]
19 : struct NodeInfo {
20 : kind: NodeKind,
21 :
22 : // walproposer
23 : is_sync: bool,
24 : term: u64,
25 : epoch_lsn: u64,
26 :
27 : // safekeeper
28 : commit_lsn: u64,
29 : flush_lsn: u64,
30 : }
31 :
32 : impl NodeInfo {
33 149613 : fn init_kind(&mut self, kind: NodeKind) {
34 149613 : if self.kind == NodeKind::Unknown {
35 84657 : self.kind = kind;
36 84657 : } else {
37 64956 : assert!(self.kind == kind);
38 : }
39 149613 : }
40 :
41 149613 : fn started(&mut self, data: &str) {
42 149613 : let mut parts = data.split(';');
43 149613 : assert!(parts.next().unwrap() == "started");
44 149613 : match parts.next().unwrap() {
45 149613 : "safekeeper" => {
46 76962 : self.init_kind(NodeKind::Safekeeper);
47 76962 : }
48 72651 : "walproposer" => {
49 72651 : self.init_kind(NodeKind::WalProposer);
50 72651 : let is_sync: u8 = parts.next().unwrap().parse().unwrap();
51 72651 : self.is_sync = is_sync != 0;
52 72651 : }
53 0 : _ => unreachable!(),
54 : }
55 149613 : }
56 : }
57 :
58 : /// Global state of the simulation, derived from the simulation logs.
59 : #[derive(Debug, Default)]
60 : struct GlobalState {
61 : nodes: Vec<NodeInfo>,
62 : commit_lsn: u64,
63 : write_lsn: u64,
64 : max_write_lsn: u64,
65 :
66 : written_wal: u64,
67 : written_records: u64,
68 : }
69 :
70 : impl GlobalState {
71 4002 : fn new() -> Self {
72 4002 : Default::default()
73 4002 : }
74 :
75 286407 : fn get(&mut self, id: u32) -> &mut NodeInfo {
76 286407 : let id = id as usize;
77 286407 : if id >= self.nodes.len() {
78 84651 : self.nodes.resize(id + 1, NodeInfo::default());
79 201756 : }
80 286407 : &mut self.nodes[id]
81 286407 : }
82 : }
83 :
84 : /// Try to find inconsistencies in the simulation log.
85 4002 : pub fn validate_events(events: Vec<SimEvent>) {
86 4002 : const INITDB_LSN: u64 = 21623024;
87 4002 :
88 4002 : let hook = std::panic::take_hook();
89 : scopeguard::defer_on_success! {
90 : std::panic::set_hook(hook);
91 : };
92 :
93 4002 : let mut state = GlobalState::new();
94 4002 : state.max_write_lsn = INITDB_LSN;
95 :
96 222012 : for event in events {
97 218010 : debug!("{:?}", event);
98 :
99 218010 : let node = state.get(event.node);
100 218010 : if event.data.starts_with("started;") {
101 149613 : node.started(&event.data);
102 149613 : continue;
103 68397 : }
104 68397 : assert!(node.kind != NodeKind::Unknown);
105 :
106 : // drop reference to unlock state
107 68397 : let mut node = node.clone();
108 68397 :
109 68397 : let mut parts = event.data.split(';');
110 68397 : match node.kind {
111 58046 : NodeKind::Safekeeper => match parts.next().unwrap() {
112 58046 : "tli_loaded" => {
113 58046 : let flush_lsn: u64 = parts.next().unwrap().parse().unwrap();
114 58046 : let commit_lsn: u64 = parts.next().unwrap().parse().unwrap();
115 58046 : node.flush_lsn = flush_lsn;
116 58046 : node.commit_lsn = commit_lsn;
117 58046 : }
118 0 : _ => unreachable!(),
119 : },
120 : NodeKind::WalProposer => {
121 10351 : match parts.next().unwrap() {
122 10351 : "prop_elected" => {
123 5389 : let prop_lsn: u64 = parts.next().unwrap().parse().unwrap();
124 5389 : let prop_term: u64 = parts.next().unwrap().parse().unwrap();
125 5389 : let prev_lsn: u64 = parts.next().unwrap().parse().unwrap();
126 5389 : let prev_term: u64 = parts.next().unwrap().parse().unwrap();
127 5389 :
128 5389 : assert!(prop_lsn >= prev_lsn);
129 5389 : assert!(prop_term >= prev_term);
130 :
131 5389 : assert!(prop_lsn >= state.commit_lsn);
132 :
133 5389 : if prop_lsn > state.write_lsn {
134 364 : assert!(prop_lsn <= state.max_write_lsn);
135 364 : debug!(
136 0 : "moving write_lsn up from {} to {}",
137 : state.write_lsn, prop_lsn
138 : );
139 364 : state.write_lsn = prop_lsn;
140 5025 : }
141 5389 : if prop_lsn < state.write_lsn {
142 896 : debug!(
143 0 : "moving write_lsn down from {} to {}",
144 : state.write_lsn, prop_lsn
145 : );
146 896 : state.write_lsn = prop_lsn;
147 4493 : }
148 :
149 5389 : node.epoch_lsn = prop_lsn;
150 5389 : node.term = prop_term;
151 : }
152 4962 : "write_wal" => {
153 2587 : assert!(!node.is_sync);
154 2587 : let start_lsn: u64 = parts.next().unwrap().parse().unwrap();
155 2587 : let end_lsn: u64 = parts.next().unwrap().parse().unwrap();
156 2587 : let cnt: u64 = parts.next().unwrap().parse().unwrap();
157 2587 :
158 2587 : let size = end_lsn - start_lsn;
159 2587 : state.written_wal += size;
160 2587 : state.written_records += cnt;
161 2587 :
162 2587 : // TODO: If we allow writing WAL before winning the election
163 2587 :
164 2587 : assert!(start_lsn >= state.commit_lsn);
165 2587 : assert!(end_lsn >= start_lsn);
166 : // assert!(start_lsn == state.write_lsn);
167 2587 : state.write_lsn = end_lsn;
168 2587 :
169 2587 : if end_lsn > state.max_write_lsn {
170 2138 : state.max_write_lsn = end_lsn;
171 2138 : }
172 : }
173 2375 : "commit_lsn" => {
174 2375 : let lsn: u64 = parts.next().unwrap().parse().unwrap();
175 2375 : assert!(lsn >= state.commit_lsn);
176 2375 : state.commit_lsn = lsn;
177 : }
178 0 : _ => unreachable!(),
179 : }
180 : }
181 0 : _ => unreachable!(),
182 : }
183 :
184 : // update the node in the state struct
185 68397 : *state.get(event.node) = node;
186 : }
187 4002 : }
|