/
logging.go
195 lines (168 loc) · 4.33 KB
/
logging.go
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
135
136
137
138
139
140
141
142
143
144
145
146
147
148
149
150
151
152
153
154
155
156
157
158
159
160
161
162
163
164
165
166
167
168
169
170
171
172
173
174
175
176
177
178
179
180
181
182
183
184
185
186
187
188
189
190
191
192
193
194
195
// SPDX-License-Identifier:Apache-2.0
// Package logging sets up structured logging in a uniform way, and
// redirects glog statements into the structured log.
package logging
import (
"bufio"
"flag"
"fmt"
"os"
"regexp"
"strconv"
"strings"
"time"
"github.com/go-kit/log"
"github.com/go-kit/log/level"
"k8s.io/klog"
ctrl "sigs.k8s.io/controller-runtime"
"sigs.k8s.io/controller-runtime/pkg/log/zap"
)
const (
LevelAll = "all"
LevelDebug = "debug"
LevelInfo = "info"
LevelWarn = "warn"
LevelError = "error"
LevelNone = "none"
)
type Level string
type levelSlice []Level
var (
// Levels returns an array of valid log levels.
Levels = levelSlice{LevelAll, LevelDebug, LevelInfo, LevelWarn, LevelError, LevelNone}
)
func (l levelSlice) String() string {
strs := make([]string, len(l))
for i, v := range l {
strs[i] = string(v)
}
return strings.Join(strs, ", ")
}
// Init returns a logger configured with common settings like
// timestamping and source code locations. Both the stdlib logger and
// glog are reconfigured to push logs into this logger.
//
// Init must be called as early as possible in main(), before any
// application-specific flag parsing or logging occurs, because it
// mutates the contents of the flag package as well as os.Stderr.
func Init(lvl string) (log.Logger, error) {
l := log.NewJSONLogger(log.NewSyncWriter(os.Stdout))
r, w, err := os.Pipe()
if err != nil {
return nil, fmt.Errorf("creating pipe for glog redirection: %s", err)
}
klog.InitFlags(flag.NewFlagSet("klog", flag.ExitOnError))
klog.SetOutput(w)
go collectGlogs(r, l)
opt, err := parseLevel(lvl)
if err != nil {
return nil, err
}
timeStampValuer := log.TimestampFormat(time.Now, time.RFC3339)
l = log.With(l, "ts", timeStampValuer)
l = level.NewFilter(l, opt)
// Note: caller must be added after everything else that decorates the
// logger (otherwise we get incorrect caller reference).
l = log.With(l, "caller", log.DefaultCaller)
// Setting a controller-runtime logger is required to
// get any log created by it.
ctrl.SetLogger(zap.New())
return l, nil
}
func collectGlogs(f *os.File, logger log.Logger) {
defer func() {
if err := f.Close(); err != nil {
// cant log here, as this is the logger
errorString := fmt.Sprintf("Error closing file: %s", err)
panic(errorString)
}
}()
r := bufio.NewReader(f)
for {
var buf []byte
l, pfx, err := r.ReadLine()
if err != nil {
// TODO: log
return
}
buf = append(buf, l...)
for pfx {
l, pfx, err = r.ReadLine()
if err != nil {
// TODO: log
return
}
buf = append(buf, l...)
}
leveledLogger, ts, caller, msg := deformat(logger, buf)
leveledLogger.Log("ts", ts.Format(time.RFC3339Nano), "caller", caller, "msg", msg)
}
}
var logPrefix = regexp.MustCompile(`^(.)(\d{2})(\d{2}) (\d{2}):(\d{2}):(\d{2}).(\d{6})\s+\d+ ([^:]+:\d+)] (.*)$`)
func deformat(logger log.Logger, b []byte) (leveledLogger log.Logger, ts time.Time, caller, msg string) {
// Default deconstruction used when anything goes wrong.
leveledLogger = level.Info(logger)
ts = time.Now()
caller = ""
msg = string(b)
if len(b) < 30 {
return
}
ms := logPrefix.FindSubmatch(b)
if ms == nil {
return
}
month, err := strconv.Atoi(string(ms[2]))
if err != nil {
return
}
day, err := strconv.Atoi(string(ms[3]))
if err != nil {
return
}
hour, err := strconv.Atoi(string(ms[4]))
if err != nil {
return
}
minute, err := strconv.Atoi(string(ms[5]))
if err != nil {
return
}
second, err := strconv.Atoi(string(ms[6]))
if err != nil {
return
}
micros, err := strconv.Atoi(string(ms[7]))
if err != nil {
return
}
ts = time.Date(ts.Year(), time.Month(month), day, hour, minute, second, micros*1000, time.Local).UTC()
switch ms[1][0] {
case 'I':
leveledLogger = level.Info(logger)
case 'W':
leveledLogger = level.Warn(logger)
case 'E', 'F':
leveledLogger = level.Error(logger)
}
caller = string(ms[8])
msg = string(ms[9])
return
}
func parseLevel(lvl string) (level.Option, error) {
switch lvl {
case LevelAll:
return level.AllowAll(), nil
case LevelDebug:
return level.AllowDebug(), nil
case LevelInfo:
return level.AllowInfo(), nil
case LevelWarn:
return level.AllowWarn(), nil
case LevelError:
return level.AllowError(), nil
case LevelNone:
return level.AllowNone(), nil
}
return nil, fmt.Errorf("failed to parse log level: %s", lvl)
}