Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Enhancement: persist commit index in LogStore to accelerate recovery #613

Open
wants to merge 20 commits into
base: main
Choose a base branch
from
Open
Show file tree
Hide file tree
Changes from all commits
Commits
Show all changes
20 commits
Select commit Hold shift + click to select a range
2e5a8a0
feat: add CommitTrackingLogStore interface for commit index management
peterxcli Sep 1, 2024
ffc6b3b
chore: remove non-idiomatic type assert func
peterxcli Sep 3, 2024
7383d96
feat(raft): add fast recovery mode for quicker log application
peterxcli Sep 4, 2024
f6295e0
feat(raft): add recovery from committed logs during startup
peterxcli Sep 4, 2024
f2ae7a9
refactor(store): rename ReadCommitIndex to GetCommitIndex for consist…
peterxcli Sep 6, 2024
ce1895c
fix: also set inmem commit index when revocer log commit progress fro…
peterxcli Sep 10, 2024
ab50a58
perf: optimize startup recovery by skipping duplicated log replay
peterxcli Sep 10, 2024
4e7e04b
refactor(inmem-commit-tracking-store): store commit index in memory u…
peterxcli Sep 13, 2024
41df55e
chore: fix typo in recoverFromCommittedLogs function name
peterxcli Sep 13, 2024
400a27d
refactor(raft): update parameter name in persistCommitIndex function
peterxcli Sep 13, 2024
e2617e8
refactor(raft): set commit index in memory before `StoreLogs`
peterxcli Sep 13, 2024
6daca47
refactor(raft): fix condition for skipping recovery in `recoverFromCo…
peterxcli Sep 18, 2024
cc09317
feat(raft): add commit tracking logs and fast recovery tests
peterxcli Sep 18, 2024
fe57b32
docs(config): update comments for FastRecovery mechanism
peterxcli Sep 19, 2024
20e8701
refactor(inmem-commit-tracking-store): simplify in-mem log tracking s…
peterxcli Sep 19, 2024
6f146e1
fix: rename persistCommitIndex to tryPersistCommitIndex
peterxcli Sep 19, 2024
a8438b0
chore(raft): rename tryPersistCommitIndex to tryStageCommitIndex for …
peterxcli Sep 20, 2024
5e6d8a4
refactor(log): introduce StagCommitIndex for optimized atomic persist…
peterxcli Sep 20, 2024
e248f00
fix(raft): correct CommitTrackingLogStore implementation
peterxcli Sep 24, 2024
2a913ab
feat(raft): improve fast recovery error handling and commit index val…
peterxcli Sep 24, 2024
File filter

Filter by extension

Filter by extension

Conversations
Failed to load comments.
Loading
Jump to
Jump to file
Failed to load files.
Loading
Diff view
Diff view
43 changes: 42 additions & 1 deletion api.go
Original file line number Diff line number Diff line change
Expand Up @@ -217,6 +217,10 @@ type Raft struct {
// preVoteDisabled control if the pre-vote feature is activated,
// prevote feature is disabled if set to true.
preVoteDisabled bool

// fastRecovery is used to enable fast recovery mode
// fast recovery mode is disabled if set to false.
fastRecovery bool
}

// BootstrapCluster initializes a server's storage with the given cluster
Expand Down Expand Up @@ -566,6 +570,7 @@ func NewRaft(conf *Config, fsm FSM, logs LogStore, stable StableStore, snaps Sna
followerNotifyCh: make(chan struct{}, 1),
mainThreadSaturation: newSaturationMetric([]string{"raft", "thread", "main", "saturation"}, 1*time.Second),
preVoteDisabled: conf.PreVoteDisabled || !transportSupportPreVote,
fastRecovery: conf.FastRecovery,
}
if !transportSupportPreVote && !conf.PreVoteDisabled {
r.logger.Warn("pre-vote is disabled because it is not supported by the Transport")
Expand All @@ -585,9 +590,12 @@ func NewRaft(conf *Config, fsm FSM, logs LogStore, stable StableStore, snaps Sna
return nil, err
}

r.recoverFromCommittedLogs()

// Scan through the log for any configuration change entries.
snapshotIndex, _ := r.getLastSnapshot()
for index := snapshotIndex + 1; index <= lastLog.Index; index++ {
lastappliedIndex := r.getLastApplied()
for index := max(snapshotIndex, lastappliedIndex) + 1; index <= lastLog.Index; index++ {
var entry Log
if err := r.logs.GetLog(index, &entry); err != nil {
r.logger.Error("failed to get log", "index", index, "error", err)
Expand Down Expand Up @@ -697,6 +705,39 @@ func (r *Raft) tryRestoreSingleSnapshot(snapshot *SnapshotMeta) bool {
return true
}

// recoverFromCommittedLogs recovers the Raft node from committed logs.
func (r *Raft) recoverFromCommittedLogs() error {
if !r.fastRecovery {
return nil
}

// If the store implements CommitTrackingLogStore, we can read the commit index from the store.
// This is useful when the store is able to track the commit index and we can avoid replaying logs.
store, ok := r.logs.(CommitTrackingLogStore)
if !ok {
return nil
}

commitIndex, err := store.GetCommitIndex()
if err != nil {
r.logger.Error("failed to get commit index from store", "error", err)
panic(err)
}

lastIndex, err := r.logs.LastIndex()
if err != nil {
r.logger.Error("failed to get last log index from store", "error", err)
panic(err)
}
if commitIndex > lastIndex {
commitIndex = lastIndex
}

r.setCommitIndex(commitIndex)
r.processLogs(commitIndex, nil)
return nil
}

func (r *Raft) config() Config {
return r.conf.Load().(Config)
}
Expand Down
10 changes: 10 additions & 0 deletions config.go
Original file line number Diff line number Diff line change
Expand Up @@ -235,6 +235,16 @@ type Config struct {
// PreVoteDisabled deactivate the pre-vote feature when set to true
PreVoteDisabled bool

// FastRecovery controls if the Raft server should use the fast recovery
// mechanism. Fast recovery requires a LogStore implementation that
// support commit tracking. When such a store is used and this config
// enabled, raft nodes will replay all known-committed logs on disk
// before completing `NewRaft` on startup. This is mainly useful where
// the application allows relaxed-consistency reads from followers as it
// will reduce how far behind the follower's FSM is when it starts. If all reads
// are forwarded to the leader then there won't be observable benefit from this feature.
FastRecovery bool

// skipStartup allows NewRaft() to bypass all background work goroutines
skipStartup bool
}
Expand Down
28 changes: 28 additions & 0 deletions inmem_store.go
Original file line number Diff line number Diff line change
Expand Up @@ -6,6 +6,7 @@ package raft
import (
"errors"
"sync"
"sync/atomic"
)

// InmemStore implements the LogStore and StableStore interface.
Expand Down Expand Up @@ -131,3 +132,30 @@ func (i *InmemStore) GetUint64(key []byte) (uint64, error) {
defer i.l.RUnlock()
return i.kvInt[string(key)], nil
}

type commitIndexTrackingLog struct {
log *Log
CommitIndex uint64
}
type InmemCommitTrackingStore struct {
lalalalatt marked this conversation as resolved.
Show resolved Hide resolved
InmemStore
commitIndex atomic.Uint64
}

// NewInmemCommitTrackingStore returns a new in-memory backend that tracks the commit index. Do not ever
// use for production. Only for testing.
func NewInmemCommitTrackingStore() CommitTrackingLogStore {
i := &InmemCommitTrackingStore{
InmemStore: *NewInmemStore(),
}
return i
}

func (i *InmemCommitTrackingStore) StageCommitIndex(index uint64) error {
i.commitIndex.Store(index)
return nil
}

func (i *InmemCommitTrackingStore) GetCommitIndex() (uint64, error) {
return i.commitIndex.Load(), nil
}
lalalalatt marked this conversation as resolved.
Show resolved Hide resolved
21 changes: 21 additions & 0 deletions log.go
Original file line number Diff line number Diff line change
Expand Up @@ -190,3 +190,24 @@ func emitLogStoreMetrics(s LogStore, prefix []string, interval time.Duration, st
}
}
}

type CommitTrackingLogStore interface {
LogStore

// StageCommitIndex stages a new commit index to be persisted.
// The staged commit index MUST only be persisted in a manner that is atomic
// with the following StoreLogs call in the face of a crash.
// This allows the Raft implementation to optimize commit index updates
// without risking inconsistency between the commit index and the log entries.
//
// The implementation MUST NOT persist this value separately from the log entries.
// Instead, it should stage the value to be written atomically with the next
// StoreLogs call.
//
// GetCommitIndex MUST never return a value higher than the last index in the log,
// even if a higher value has been staged with this method.
//
// idx is the new commit index to stage.
StageCommitIndex(idx uint64) error
GetCommitIndex() (uint64, error)
}
22 changes: 22 additions & 0 deletions raft.go
Original file line number Diff line number Diff line change
Expand Up @@ -1262,6 +1262,9 @@ func (r *Raft) dispatchLogs(applyLogs []*logFuture) {
r.leaderState.inflight.PushBack(applyLog)
}

commitIndex := r.getCommitIndex()
r.tryStageCommitIndex(commitIndex)

// Write the log entry locally
if err := r.logs.StoreLogs(logs); err != nil {
r.logger.Error("failed to commit logs", "error", err)
Expand Down Expand Up @@ -1385,6 +1388,20 @@ func (r *Raft) prepareLog(l *Log, future *logFuture) *commitTuple {
return nil
}

// tryStageCommitIndex updates the commit index in persist store if fast recovery is enabled and log store implements CommitTrackingLogStore.
func (r *Raft) tryStageCommitIndex(commitIndex uint64) {
if !r.fastRecovery {
return
}
store, ok := r.logs.(CommitTrackingLogStore)
if !ok {
return
}
if err := store.StageCommitIndex(commitIndex); err != nil {
r.logger.Error("failed to stage commit index in commit tracking log store", "index", commitIndex, "error", err)
}
}

// processRPC is called to handle an incoming RPC request. This must only be
// called from the main thread.
func (r *Raft) processRPC(rpc RPC) {
Expand Down Expand Up @@ -1535,6 +1552,11 @@ func (r *Raft) appendEntries(rpc RPC, a *AppendEntriesRequest) {
}

if n := len(newEntries); n > 0 {
// Stage the future commit index if possible
lastNewIndex := newEntries[len(newEntries)-1].Index
commitIndex := min(a.LeaderCommitIndex, lastNewIndex)
r.tryStageCommitIndex(commitIndex)

// Append the new entries
if err := r.logs.StoreLogs(newEntries); err != nil {
r.logger.Error("failed to append to logs", "error", err)
Expand Down
174 changes: 174 additions & 0 deletions raft_test.go
Original file line number Diff line number Diff line change
Expand Up @@ -1095,6 +1095,180 @@ func TestRaft_RestoreSnapshotOnStartup_Monotonic(t *testing.T) {
assert.Equal(t, lastIdx, last)
}

func TestRaft_RestoreSnapshotOnStartup_CommitTrackingLogs(t *testing.T) {
// Make the cluster
conf := inmemConfig(t)
conf.TrailingLogs = 10
opts := &MakeClusterOpts{
Peers: 1,
Bootstrap: true,
Conf: conf,
CommitTrackingLogs: true,
}
c := MakeClusterCustom(t, opts)
defer c.Close()

leader := c.Leader()

// Commit a lot of things
var future Future
for i := 0; i < 100; i++ {
future = leader.Apply([]byte(fmt.Sprintf("test%d", i)), 0)
}

// Wait for the last future to apply
if err := future.Error(); err != nil {
t.Fatalf("err: %v", err)
}

// Take a snapshot
snapFuture := leader.Snapshot()
if err := snapFuture.Error(); err != nil {
t.Fatalf("err: %v", err)
}

// Check for snapshot
snaps, _ := leader.snapshots.List()
if len(snaps) != 1 {
t.Fatalf("should have a snapshot")
}
snap := snaps[0]

// Logs should be trimmed
firstIdx, err := leader.logs.FirstIndex()
if err != nil {
t.Fatalf("err: %v", err)
}
lastIdx, err := leader.logs.LastIndex()
if err != nil {
t.Fatalf("err: %v", err)
}

if firstIdx != snap.Index-conf.TrailingLogs+1 {
t.Fatalf("should trim logs to %d: but is %d", snap.Index-conf.TrailingLogs+1, firstIdx)
}

// Shutdown
shutdown := leader.Shutdown()
if err := shutdown.Error(); err != nil {
t.Fatalf("err: %v", err)
}

// Restart the Raft
r := leader
// Can't just reuse the old transport as it will be closed
_, trans2 := NewInmemTransport(r.trans.LocalAddr())
cfg := r.config()
r, err = NewRaft(&cfg, r.fsm, r.logs, r.stable, r.snapshots, trans2)
if err != nil {
t.Fatalf("err: %v", err)
}
c.rafts[0] = r

// We should have restored from the snapshot!
if last := r.getLastApplied(); last != snap.Index {
t.Fatalf("bad last index: %d, expecting %d", last, snap.Index)
}

// Verify that logs have not been reset
first, _ := r.logs.FirstIndex()
last, _ := r.logs.LastIndex()
assert.Equal(t, firstIdx, first)
assert.Equal(t, lastIdx, last)
}

func TestRaft_FastRecovery(t *testing.T) {
// Make the cluster
conf := inmemConfig(t)
conf.TrailingLogs = 10
conf.FastRecovery = true
opts := &MakeClusterOpts{
Peers: 1,
Bootstrap: true,
Conf: conf,
CommitTrackingLogs: true,
}
c := MakeClusterCustom(t, opts)
defer c.Close()

leader := c.Leader()

// Commit a lot of things
var future Future
for i := 0; i < 100; i++ {
future = leader.Apply([]byte(fmt.Sprintf("test%d", i)), 0)
}

// Wait for the last future to apply
if err := future.Error(); err != nil {
t.Fatalf("err: %v", err)
}

// Take a snapshot
snapFuture := leader.Snapshot()
if err := snapFuture.Error(); err != nil {
t.Fatalf("err: %v", err)
}

// Check for snapshot
snaps, _ := leader.snapshots.List()
if len(snaps) != 1 {
t.Fatalf("should have a snapshot")
}
snap := snaps[0]

// Logs should be trimmed
firstIdx, err := leader.logs.FirstIndex()
if err != nil {
t.Fatalf("err: %v", err)
}

if firstIdx != snap.Index-conf.TrailingLogs+1 {
t.Fatalf("should trim logs to %d: but is %d", snap.Index-conf.TrailingLogs+1, firstIdx)
}

// Commit a lot of things (for fast recovery test)
for i := 0; i < 100; i++ {
future = leader.Apply([]byte(fmt.Sprintf("test%d", i)), 0)
}

// Wait for the last future to apply
if err := future.Error(); err != nil {
t.Fatalf("err: %v", err)
}

// Shutdown
shutdown := leader.Shutdown()
if err := shutdown.Error(); err != nil {
t.Fatalf("err: %v", err)
}

// Restart the Raft
r := leader
// Can't just reuse the old transport as it will be closed
_, trans2 := NewInmemTransport(r.trans.LocalAddr())
cfg := r.config()
r, err = NewRaft(&cfg, r.fsm, r.logs, r.stable, r.snapshots, trans2)
if err != nil {
t.Fatalf("err: %v", err)
}
c.rafts[0] = r

commitIdx, err := r.logs.(CommitTrackingLogStore).GetCommitIndex()
// We should have applied all committed logs
if last := r.getLastApplied(); last != commitIdx {
t.Fatalf("bad last index: %d, expecting %d", last, commitIdx)
}

// Expect: snap.Index --- commitIdx --- lastIdx
lastIdx, err := r.logs.LastIndex()
if err != nil {
t.Fatalf("err: %v", err)
}
assert.LessOrEqual(t, snap.Index, commitIdx)
assert.LessOrEqual(t, commitIdx, lastIdx)
}
Copy link
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

I'm assuming these tests are failing right now because the InmemStore wasn't updated to match the new interface right? If they are passing for you then it might be worth a look!

Copy link
Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

It passes😱

Copy link
Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Hi @banks
First I want to thanks that you reviewed so many changes and gave lots of advices and opinions. 😁


Back to this topic, I think this test case is ok🤔.

Because basically the commit index stored in the store would always lower than the last log index in store (there is always one StoreLogs call lag).

As the comment "Expect: snap.Index --- commitIdx --- lastIdx" leaved, I think we can't sure what is the exact position of the commitIndex in every test, so I just test the interval only.
But now we find this would lead to another problem - we can't even detect the commit store interface and its implementation aren't match😱.
We can simply solve that detection issue by changing assert.LessOrEqual to assert.Less, but that would another flaky problem because of the uncertainty of the commit index.

What do you think?


func TestRaft_SnapshotRestore_Progress(t *testing.T) {
// Make the cluster
conf := inmemConfig(t)
Expand Down
Loading