2020-09-01 15:21:19 +08:00
|
|
|
package filer
|
2018-08-13 16:20:49 +08:00
|
|
|
|
|
|
|
import (
|
2020-04-28 14:49:46 +08:00
|
|
|
"context"
|
2020-03-30 16:19:33 +08:00
|
|
|
"fmt"
|
2024-01-08 16:03:08 +08:00
|
|
|
"github.com/seaweedfs/seaweedfs/weed/util/log_buffer"
|
2020-04-28 14:49:46 +08:00
|
|
|
"io"
|
2021-09-25 16:18:44 +08:00
|
|
|
"math"
|
2022-12-20 03:30:50 +08:00
|
|
|
"regexp"
|
2020-03-30 16:19:33 +08:00
|
|
|
"strings"
|
|
|
|
"time"
|
|
|
|
|
2022-08-18 03:05:07 +08:00
|
|
|
"google.golang.org/protobuf/proto"
|
2020-03-30 16:19:33 +08:00
|
|
|
|
2022-07-29 15:17:28 +08:00
|
|
|
"github.com/seaweedfs/seaweedfs/weed/glog"
|
|
|
|
"github.com/seaweedfs/seaweedfs/weed/notification"
|
|
|
|
"github.com/seaweedfs/seaweedfs/weed/pb/filer_pb"
|
|
|
|
"github.com/seaweedfs/seaweedfs/weed/util"
|
2018-08-13 16:20:49 +08:00
|
|
|
)
|
|
|
|
|
2020-08-29 14:48:48 +08:00
|
|
|
func (f *Filer) NotifyUpdateEvent(ctx context.Context, oldEntry, newEntry *Entry, deleteChunks, isFromOtherCluster bool, signatures []int32) {
|
2020-03-31 04:03:43 +08:00
|
|
|
var fullpath string
|
2018-08-13 16:20:49 +08:00
|
|
|
if oldEntry != nil {
|
2020-03-31 04:03:43 +08:00
|
|
|
fullpath = string(oldEntry.FullPath)
|
2018-08-13 16:20:49 +08:00
|
|
|
} else if newEntry != nil {
|
2020-03-31 04:03:43 +08:00
|
|
|
fullpath = string(newEntry.FullPath)
|
2018-08-13 16:20:49 +08:00
|
|
|
} else {
|
|
|
|
return
|
|
|
|
}
|
|
|
|
|
2020-03-31 04:03:43 +08:00
|
|
|
// println("fullpath:", fullpath)
|
2020-03-30 16:19:33 +08:00
|
|
|
|
2020-04-13 05:03:07 +08:00
|
|
|
if strings.HasPrefix(fullpath, SystemLogDir) {
|
2020-03-30 16:19:33 +08:00
|
|
|
return
|
|
|
|
}
|
2020-09-10 02:21:23 +08:00
|
|
|
foundSelf := false
|
|
|
|
for _, sig := range signatures {
|
|
|
|
if sig == f.Signature {
|
|
|
|
foundSelf = true
|
|
|
|
}
|
|
|
|
}
|
|
|
|
if !foundSelf {
|
|
|
|
signatures = append(signatures, f.Signature)
|
|
|
|
}
|
2018-08-13 16:33:21 +08:00
|
|
|
|
2020-03-30 16:19:33 +08:00
|
|
|
newParentPath := ""
|
|
|
|
if newEntry != nil {
|
|
|
|
newParentPath, _ = newEntry.FullPath.DirAndName()
|
|
|
|
}
|
|
|
|
eventNotification := &filer_pb.EventNotification{
|
2020-07-01 23:06:20 +08:00
|
|
|
OldEntry: oldEntry.ToProtoEntry(),
|
|
|
|
NewEntry: newEntry.ToProtoEntry(),
|
|
|
|
DeleteChunks: deleteChunks,
|
|
|
|
NewParentPath: newParentPath,
|
|
|
|
IsFromOtherCluster: isFromOtherCluster,
|
2020-09-10 02:21:23 +08:00
|
|
|
Signatures: signatures,
|
2020-03-30 16:19:33 +08:00
|
|
|
}
|
|
|
|
|
|
|
|
if notification.Queue != nil {
|
2020-07-01 23:06:20 +08:00
|
|
|
glog.V(3).Infof("notifying entry update %v", fullpath)
|
2021-02-11 16:59:36 +08:00
|
|
|
if err := notification.Queue.SendMessage(fullpath, eventNotification); err != nil {
|
|
|
|
// throw message
|
|
|
|
glog.Error(err)
|
|
|
|
}
|
2020-03-30 16:19:33 +08:00
|
|
|
}
|
|
|
|
|
2020-06-29 05:34:51 +08:00
|
|
|
f.logMetaEvent(ctx, fullpath, eventNotification)
|
2020-03-30 16:19:33 +08:00
|
|
|
|
|
|
|
}
|
|
|
|
|
2020-06-29 05:34:51 +08:00
|
|
|
func (f *Filer) logMetaEvent(ctx context.Context, fullpath string, eventNotification *filer_pb.EventNotification) {
|
2020-03-31 04:03:43 +08:00
|
|
|
|
|
|
|
dir, _ := util.FullPath(fullpath).DirAndName()
|
|
|
|
|
2020-04-13 12:00:55 +08:00
|
|
|
event := &filer_pb.SubscribeMetadataResponse{
|
2020-03-30 16:19:33 +08:00
|
|
|
Directory: dir,
|
|
|
|
EventNotification: eventNotification,
|
2020-04-22 12:16:13 +08:00
|
|
|
TsNs: time.Now().UnixNano(),
|
2020-03-30 16:19:33 +08:00
|
|
|
}
|
|
|
|
data, err := proto.Marshal(event)
|
|
|
|
if err != nil {
|
2020-04-13 12:00:55 +08:00
|
|
|
glog.Errorf("failed to marshal filer_pb.SubscribeMetadataResponse %+v: %v", event, err)
|
2020-03-30 16:19:33 +08:00
|
|
|
return
|
|
|
|
}
|
|
|
|
|
2020-08-30 08:37:19 +08:00
|
|
|
f.LocalMetaLogBuffer.AddToBuffer([]byte(dir), data, event.TsNs)
|
2020-03-30 16:19:33 +08:00
|
|
|
|
|
|
|
}
|
|
|
|
|
|
|
|
func (f *Filer) logFlushFunc(startTime, stopTime time.Time, buf []byte) {
|
2020-04-09 11:32:57 +08:00
|
|
|
|
2020-10-22 15:35:46 +08:00
|
|
|
if len(buf) == 0 {
|
|
|
|
return
|
|
|
|
}
|
|
|
|
|
2020-08-30 12:01:14 +08:00
|
|
|
startTime, stopTime = startTime.UTC(), stopTime.UTC()
|
|
|
|
|
2021-09-25 16:18:44 +08:00
|
|
|
targetFile := fmt.Sprintf("%s/%04d-%02d-%02d/%02d-%02d.%08x", SystemLogDir,
|
2022-07-24 01:50:28 +08:00
|
|
|
startTime.Year(), startTime.Month(), startTime.Day(), startTime.Hour(), startTime.Minute(), f.UniqueFilerId,
|
2020-04-13 05:03:07 +08:00
|
|
|
// startTime.Second(), startTime.Nanosecond(),
|
|
|
|
)
|
2018-09-17 02:20:36 +08:00
|
|
|
|
2020-07-15 02:25:50 +08:00
|
|
|
for {
|
|
|
|
if err := f.appendToFile(targetFile, buf); err != nil {
|
2022-05-11 15:45:19 +08:00
|
|
|
glog.V(0).Infof("metadata log write failed %s: %v", targetFile, err)
|
2020-07-15 02:25:50 +08:00
|
|
|
time.Sleep(737 * time.Millisecond)
|
|
|
|
} else {
|
|
|
|
break
|
|
|
|
}
|
2020-03-30 16:19:33 +08:00
|
|
|
}
|
|
|
|
}
|
2020-04-28 14:49:46 +08:00
|
|
|
|
2022-12-20 03:30:50 +08:00
|
|
|
var (
|
|
|
|
VolumeNotFoundPattern = regexp.MustCompile(`volume \d+? not found`)
|
|
|
|
)
|
|
|
|
|
2024-01-08 16:03:08 +08:00
|
|
|
func (f *Filer) ReadPersistedLogBuffer(startPosition log_buffer.MessagePosition, stopTsNs int64, eachLogEntryFn func(logEntry *filer_pb.LogEntry) error) (lastTsNs int64, isDone bool, err error) {
|
2020-04-28 14:49:46 +08:00
|
|
|
|
2024-01-08 16:03:08 +08:00
|
|
|
startDate := fmt.Sprintf("%04d-%02d-%02d", startPosition.Year(), startPosition.Month(), startPosition.Day())
|
|
|
|
startHourMinute := fmt.Sprintf("%02d-%02d", startPosition.Hour(), startPosition.Minute())
|
2022-05-31 06:04:19 +08:00
|
|
|
var stopDate, stopHourMinute string
|
|
|
|
if stopTsNs != 0 {
|
|
|
|
stopTime := time.Unix(0, stopTsNs+24*60*60*int64(time.Nanosecond)).UTC()
|
|
|
|
stopDate = fmt.Sprintf("%04d-%02d-%02d", stopTime.Year(), stopTime.Month(), stopTime.Day())
|
|
|
|
stopHourMinute = fmt.Sprintf("%02d-%02d", stopTime.Hour(), stopTime.Minute())
|
|
|
|
}
|
2020-04-28 14:49:46 +08:00
|
|
|
|
|
|
|
sizeBuf := make([]byte, 4)
|
2024-01-08 16:03:08 +08:00
|
|
|
startTsNs := startPosition.UnixNano()
|
2020-04-28 14:49:46 +08:00
|
|
|
|
2022-05-31 06:04:19 +08:00
|
|
|
dayEntries, _, listDayErr := f.ListDirectoryEntries(context.Background(), SystemLogDir, startDate, true, math.MaxInt32, "", "", "")
|
2020-04-28 14:49:46 +08:00
|
|
|
if listDayErr != nil {
|
2022-05-31 06:20:51 +08:00
|
|
|
return lastTsNs, isDone, fmt.Errorf("fail to list log by day: %v", listDayErr)
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
|
|
|
for _, dayEntry := range dayEntries {
|
2022-05-31 06:04:19 +08:00
|
|
|
if stopDate != "" {
|
|
|
|
if strings.Compare(dayEntry.Name(), stopDate) > 0 {
|
|
|
|
break
|
|
|
|
}
|
|
|
|
}
|
2020-04-28 14:49:46 +08:00
|
|
|
// println("checking day", dayEntry.FullPath)
|
2021-09-25 16:18:44 +08:00
|
|
|
hourMinuteEntries, _, listHourMinuteErr := f.ListDirectoryEntries(context.Background(), util.NewFullPath(SystemLogDir, dayEntry.Name()), "", false, math.MaxInt32, "", "", "")
|
2020-04-28 14:49:46 +08:00
|
|
|
if listHourMinuteErr != nil {
|
2022-05-31 06:20:51 +08:00
|
|
|
return lastTsNs, isDone, fmt.Errorf("fail to list log %s by day: %v", dayEntry.Name(), listHourMinuteErr)
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
|
|
|
for _, hourMinuteEntry := range hourMinuteEntries {
|
|
|
|
// println("checking hh-mm", hourMinuteEntry.FullPath)
|
|
|
|
if dayEntry.Name() == startDate {
|
2021-09-25 16:18:44 +08:00
|
|
|
hourMinute := util.FileNameBase(hourMinuteEntry.Name())
|
|
|
|
if strings.Compare(hourMinute, startHourMinute) < 0 {
|
2020-04-28 14:49:46 +08:00
|
|
|
continue
|
|
|
|
}
|
|
|
|
}
|
2022-05-31 06:04:19 +08:00
|
|
|
if dayEntry.Name() == stopDate {
|
|
|
|
hourMinute := util.FileNameBase(hourMinuteEntry.Name())
|
|
|
|
if strings.Compare(hourMinute, stopHourMinute) > 0 {
|
|
|
|
break
|
|
|
|
}
|
|
|
|
}
|
2020-04-28 14:49:46 +08:00
|
|
|
// println("processing", hourMinuteEntry.FullPath)
|
2022-11-15 22:33:36 +08:00
|
|
|
chunkedFileReader := NewChunkStreamReaderFromFiler(f.MasterClient, hourMinuteEntry.GetChunks())
|
2022-05-31 06:04:19 +08:00
|
|
|
if lastTsNs, err = ReadEachLogEntry(chunkedFileReader, sizeBuf, startTsNs, stopTsNs, eachLogEntryFn); err != nil {
|
2020-04-28 14:49:46 +08:00
|
|
|
chunkedFileReader.Close()
|
|
|
|
if err == io.EOF {
|
2020-08-30 08:37:19 +08:00
|
|
|
continue
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
2022-12-20 03:30:50 +08:00
|
|
|
if VolumeNotFoundPattern.MatchString(err.Error()) {
|
|
|
|
glog.Warningf("skipping reading %s: %v", hourMinuteEntry.FullPath, err)
|
|
|
|
continue
|
|
|
|
}
|
2022-05-31 06:20:51 +08:00
|
|
|
return lastTsNs, isDone, fmt.Errorf("reading %s: %v", hourMinuteEntry.FullPath, err)
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
|
|
|
chunkedFileReader.Close()
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
2022-05-31 06:20:51 +08:00
|
|
|
return lastTsNs, isDone, nil
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
|
|
|
|
2022-05-31 06:04:19 +08:00
|
|
|
func ReadEachLogEntry(r io.Reader, sizeBuf []byte, startTsNs, stopTsNs int64, eachLogEntryFn func(logEntry *filer_pb.LogEntry) error) (lastTsNs int64, err error) {
|
2020-04-28 14:49:46 +08:00
|
|
|
for {
|
|
|
|
n, err := r.Read(sizeBuf)
|
|
|
|
if err != nil {
|
2020-07-06 06:43:06 +08:00
|
|
|
return lastTsNs, err
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
|
|
|
if n != 4 {
|
2020-07-06 06:43:06 +08:00
|
|
|
return lastTsNs, fmt.Errorf("size %d bytes, expected 4 bytes", n)
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
|
|
|
size := util.BytesToUint32(sizeBuf)
|
2020-04-30 18:05:34 +08:00
|
|
|
// println("entry size", size)
|
2020-04-28 14:49:46 +08:00
|
|
|
entryData := make([]byte, size)
|
|
|
|
n, err = r.Read(entryData)
|
|
|
|
if err != nil {
|
2020-07-06 06:43:06 +08:00
|
|
|
return lastTsNs, err
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
|
|
|
if n != int(size) {
|
2020-07-06 06:43:06 +08:00
|
|
|
return lastTsNs, fmt.Errorf("entry data %d bytes, expected %d bytes", n, size)
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
|
|
|
logEntry := &filer_pb.LogEntry{}
|
|
|
|
if err = proto.Unmarshal(entryData, logEntry); err != nil {
|
2020-07-06 06:43:06 +08:00
|
|
|
return lastTsNs, err
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
2022-05-31 06:04:19 +08:00
|
|
|
if logEntry.TsNs <= startTsNs {
|
2021-01-11 18:08:55 +08:00
|
|
|
continue
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
2022-05-31 06:04:19 +08:00
|
|
|
if stopTsNs != 0 && logEntry.TsNs > stopTsNs {
|
|
|
|
return lastTsNs, err
|
|
|
|
}
|
2020-04-28 14:49:46 +08:00
|
|
|
// println("each log: ", logEntry.TsNs)
|
|
|
|
if err := eachLogEntryFn(logEntry); err != nil {
|
2020-07-06 06:43:06 +08:00
|
|
|
return lastTsNs, err
|
|
|
|
} else {
|
|
|
|
lastTsNs = logEntry.TsNs
|
2020-04-28 14:49:46 +08:00
|
|
|
}
|
|
|
|
}
|
|
|
|
}
|