Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 1 | // Copyright 2020 The Monogon Project Authors. |
| 2 | // |
| 3 | // SPDX-License-Identifier: Apache-2.0 |
| 4 | // |
| 5 | // Licensed under the Apache License, Version 2.0 (the "License"); |
| 6 | // you may not use this file except in compliance with the License. |
| 7 | // You may obtain a copy of the License at |
| 8 | // |
| 9 | // http://www.apache.org/licenses/LICENSE-2.0 |
| 10 | // |
| 11 | // Unless required by applicable law or agreed to in writing, software |
| 12 | // distributed under the License is distributed on an "AS IS" BASIS, |
| 13 | // WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. |
| 14 | // See the License for the specific language governing permissions and |
| 15 | // limitations under the License. |
| 16 | |
| 17 | package logtree |
| 18 | |
| 19 | import ( |
| 20 | "fmt" |
Serge Bazanski | b027218 | 2020-11-02 18:39:44 +0100 | [diff] [blame] | 21 | "strconv" |
| 22 | "strings" |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 23 | "time" |
Serge Bazanski | b027218 | 2020-11-02 18:39:44 +0100 | [diff] [blame] | 24 | |
Mateusz Zalega | cf92f40 | 2022-07-08 15:08:48 +0200 | [diff] [blame] | 25 | tpb "google.golang.org/protobuf/types/known/timestamppb" |
| 26 | |
Serge Bazanski | 31370b0 | 2021-01-07 16:31:14 +0100 | [diff] [blame] | 27 | apb "source.monogon.dev/metropolis/proto/api" |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 28 | ) |
| 29 | |
Serge Bazanski | 216fe7b | 2021-05-21 18:36:16 +0200 | [diff] [blame] | 30 | // LeveledPayload is a log entry for leveled logs (as per leveled.go). It contains |
| 31 | // the input to these calls (severity and message split into newline-delimited |
| 32 | // messages) and additional metadata that would be usually seen in a text |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 33 | // representation of a leveled log entry. |
Serge Bazanski | 1bfa0c2 | 2020-10-14 16:45:07 +0200 | [diff] [blame] | 34 | type LeveledPayload struct { |
Serge Bazanski | 216fe7b | 2021-05-21 18:36:16 +0200 | [diff] [blame] | 35 | // messages is the list of messages contained in this payload. This list is built |
| 36 | // from splitting up the given message from the user by newline. |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 37 | messages []string |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 38 | // timestamp is the time at which this message was emitted. |
| 39 | timestamp time.Time |
| 40 | // severity is the leveled Severity at which this message was emitted. |
| 41 | severity Severity |
| 42 | // file is the filename of the caller that emitted this message. |
| 43 | file string |
| 44 | // line is the line number within the file of the caller that emitted this message. |
| 45 | line int |
| 46 | } |
| 47 | |
Serge Bazanski | 216fe7b | 2021-05-21 18:36:16 +0200 | [diff] [blame] | 48 | // String returns a canonical representation of this payload as a single string |
| 49 | // prefixed with metadata. If the original message was logged with newlines, this |
| 50 | // representation will also contain newlines, with each original message part |
| 51 | // prefixed by the metadata. For an alternative call that will instead return a |
| 52 | // canonical prefix and a list of lines in the message, see Strings(). |
Serge Bazanski | 1bfa0c2 | 2020-10-14 16:45:07 +0200 | [diff] [blame] | 53 | func (p *LeveledPayload) String() string { |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 54 | prefix, lines := p.Strings() |
| 55 | res := make([]string, len(p.messages)) |
| 56 | for i, line := range lines { |
| 57 | res[i] = fmt.Sprintf("%s%s", prefix, line) |
| 58 | } |
| 59 | return strings.Join(res, "\n") |
| 60 | } |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 61 | |
Serge Bazanski | 216fe7b | 2021-05-21 18:36:16 +0200 | [diff] [blame] | 62 | // Strings returns the canonical representation of this payload split into a |
| 63 | // prefix and all lines that were contained in the original message. This is |
| 64 | // meant to be displayed to the user by showing the prefix before each line, |
| 65 | // concatenated together - possibly in a table form with the prefixes all |
| 66 | // unified with a rowspan- like mechanism. |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 67 | // |
| 68 | // For example, this function can return: |
| 69 | // prefix = "I1102 17:20:06.921395 foo.go:42] " |
| 70 | // lines = []string{"current tags:", " - one", " - two"} |
| 71 | // |
| 72 | // With this data, the result should be presented to users this way in text form: |
| 73 | // I1102 17:20:06.921395 foo.go:42] current tags: |
| 74 | // I1102 17:20:06.921395 foo.go:42] - one |
| 75 | // I1102 17:20:06.921395 foo.go:42] - two |
| 76 | // |
| 77 | // Or, in a table layout: |
| 78 | // .-----------------------------------------------------------. |
| 79 | // | I1102 17:20:06.921395 0 foo.go:42] : current tags: | |
| 80 | // | :------------------| |
| 81 | // | : - one | |
| 82 | // | :------------------| |
| 83 | // | : - two | |
| 84 | // '-----------------------------------------------------------' |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 85 | func (p *LeveledPayload) Strings() (prefix string, lines []string) { |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 86 | _, month, day := p.timestamp.Date() |
| 87 | hour, minute, second := p.timestamp.Clock() |
| 88 | nsec := p.timestamp.Nanosecond() / 1000 |
| 89 | |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 90 | // Same format as in glog, but without treadid. |
| 91 | // Lmmdd hh:mm:ss.uuuuuu file:line] |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 92 | // TODO(q3k): rewrite this to printf-less code. |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 93 | prefix = fmt.Sprintf("%s%02d%02d %02d:%02d:%02d.%06d %s:%d] ", p.severity, month, day, hour, minute, second, nsec, p.file, p.line) |
| 94 | |
| 95 | lines = p.messages |
| 96 | return |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 97 | } |
| 98 | |
Serge Bazanski | 216fe7b | 2021-05-21 18:36:16 +0200 | [diff] [blame] | 99 | // Message returns the inner message lines of this entry, ie. what was passed to |
| 100 | // the actual logging method, but split by newlines. |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 101 | func (p *LeveledPayload) Messages() []string { return p.messages } |
| 102 | |
| 103 | func (p *LeveledPayload) MessagesJoined() string { return strings.Join(p.messages, "\n") } |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 104 | |
| 105 | // Timestamp returns the time at which this entry was logged. |
Serge Bazanski | 1bfa0c2 | 2020-10-14 16:45:07 +0200 | [diff] [blame] | 106 | func (p *LeveledPayload) Timestamp() time.Time { return p.timestamp } |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 107 | |
Serge Bazanski | 216fe7b | 2021-05-21 18:36:16 +0200 | [diff] [blame] | 108 | // Location returns a string in the form of file_name:line_number that shows the |
| 109 | // origin of the log entry in the program source. |
Serge Bazanski | 1bfa0c2 | 2020-10-14 16:45:07 +0200 | [diff] [blame] | 110 | func (p *LeveledPayload) Location() string { return fmt.Sprintf("%s:%d", p.file, p.line) } |
Serge Bazanski | 5faa2fc | 2020-09-07 14:09:30 +0200 | [diff] [blame] | 111 | |
| 112 | // Severity returns the Severity with which this entry was logged. |
Serge Bazanski | 1bfa0c2 | 2020-10-14 16:45:07 +0200 | [diff] [blame] | 113 | func (p *LeveledPayload) Severity() Severity { return p.severity } |
Serge Bazanski | b027218 | 2020-11-02 18:39:44 +0100 | [diff] [blame] | 114 | |
| 115 | // Proto converts a LeveledPayload to protobuf format. |
| 116 | func (p *LeveledPayload) Proto() *apb.LogEntry_Leveled { |
| 117 | return &apb.LogEntry_Leveled{ |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 118 | Lines: p.Messages(), |
Mateusz Zalega | cf92f40 | 2022-07-08 15:08:48 +0200 | [diff] [blame] | 119 | Timestamp: tpb.New(p.Timestamp()), |
Serge Bazanski | b027218 | 2020-11-02 18:39:44 +0100 | [diff] [blame] | 120 | Severity: p.Severity().ToProto(), |
| 121 | Location: p.Location(), |
| 122 | } |
| 123 | } |
| 124 | |
| 125 | // LeveledPayloadFromProto parses a protobuf message into the internal format. |
| 126 | func LeveledPayloadFromProto(p *apb.LogEntry_Leveled) (*LeveledPayload, error) { |
| 127 | severity, err := SeverityFromProto(p.Severity) |
| 128 | if err != nil { |
| 129 | return nil, fmt.Errorf("could not convert severity: %w", err) |
| 130 | } |
| 131 | parts := strings.Split(p.Location, ":") |
| 132 | if len(parts) != 2 { |
| 133 | return nil, fmt.Errorf("invalid location, must be two :-delimited parts, is %d parts", len(parts)) |
| 134 | } |
| 135 | file := parts[0] |
| 136 | line, err := strconv.Atoi(parts[1]) |
| 137 | if err != nil { |
| 138 | return nil, fmt.Errorf("invalid location line number: %w", err) |
| 139 | } |
| 140 | return &LeveledPayload{ |
Serge Bazanski | 12971d6 | 2020-11-17 12:12:58 +0100 | [diff] [blame] | 141 | messages: p.Lines, |
Mateusz Zalega | cf92f40 | 2022-07-08 15:08:48 +0200 | [diff] [blame] | 142 | timestamp: p.Timestamp.AsTime(), |
Serge Bazanski | b027218 | 2020-11-02 18:39:44 +0100 | [diff] [blame] | 143 | severity: severity, |
| 144 | file: file, |
| 145 | line: line, |
| 146 | }, nil |
| 147 | } |
Serge Bazanski | 020b7c5 | 2021-07-07 14:22:28 +0200 | [diff] [blame] | 148 | |
| 149 | // ExternalLeveledPayload is a LeveledPayload received from an external source, |
| 150 | // eg. from parsing the logging output of third-party programs. It can be |
| 151 | // converted into a LeveledPayload and inserted into a leveled logger, but will |
| 152 | // be sanitized before that, ensuring that potentially buggy |
| 153 | // emitters/converters do not end up polluting the leveled logger data. |
| 154 | // |
| 155 | // This type should be used only when inserting data from external systems, not |
| 156 | // by code that just wishes to log things. In the future, data inserted this |
| 157 | // way might be explicitly marked as tainted so operators can understand that |
| 158 | // parts of this data might not give the same guarantees as the log entries |
| 159 | // emitted by the native LeveledLogger API. |
| 160 | type ExternalLeveledPayload struct { |
| 161 | // Log line. If any newlines are found, they will split the message into |
| 162 | // multiple messages within LeveledPayload. Empty messages are accepted |
| 163 | // verbatim. |
| 164 | Message string |
| 165 | // Timestamp when this payload was emitted according to its source. If not |
| 166 | // given, will default to the time of conversion to LeveledPayload. |
| 167 | Timestamp time.Time |
| 168 | // Log severity. If invalid or unset will default to INFO. |
| 169 | Severity Severity |
| 170 | // File name of originating code. Defaults to "unknown" if not set. |
| 171 | File string |
| 172 | // Line in File. Zero indicates the line is not known. |
| 173 | Line int |
| 174 | } |
| 175 | |
| 176 | // sanitize the given ExternalLeveledPayload by creating a corresponding |
| 177 | // LeveledPayload. The original object is unaltered. |
| 178 | func (e *ExternalLeveledPayload) sanitize() *LeveledPayload { |
| 179 | l := &LeveledPayload{ |
| 180 | messages: strings.Split(e.Message, "\n"), |
| 181 | timestamp: e.Timestamp, |
| 182 | severity: e.Severity, |
| 183 | file: e.File, |
| 184 | line: e.Line, |
| 185 | } |
| 186 | if l.timestamp.IsZero() { |
| 187 | l.timestamp = time.Now() |
| 188 | } |
| 189 | if !l.severity.Valid() { |
| 190 | l.severity = INFO |
| 191 | } |
| 192 | if l.file == "" { |
| 193 | l.file = "unknown" |
| 194 | } |
| 195 | if l.line < 0 { |
| 196 | l.line = 0 |
| 197 | } |
| 198 | return l |
| 199 | } |