Skip to content

Commit

Permalink
(maint) Add flexibility to logged? to not only match a single line
Browse files Browse the repository at this point in the history
  • Loading branch information
rileynewton committed May 21, 2024
1 parent 55350f0 commit c3e723d
Show file tree
Hide file tree
Showing 4 changed files with 36 additions and 8 deletions.
3 changes: 3 additions & 0 deletions CHANGELOG.md
Original file line number Diff line number Diff line change
@@ -1,3 +1,6 @@
## 4.0.1
* adds a new arity to `logged?` that removes the restriction that only one log line must match the pattern, adds printing to the function and repo documentation to make users aware of this single line match restriction

## 4.0.0

This is a major release with breaking changes.
Expand Down
8 changes: 6 additions & 2 deletions documentation/Test-Utils.md
Original file line number Diff line number Diff line change
Expand Up @@ -44,11 +44,15 @@ since the beginning of the form.
See the `logged?` docstring for a complete description, but as an
example, if the first argument is a regex pattern (typically generated
via Clojure's `#"pattern"`), then `logged?` will return true if the
pattern matches the message of anything that has been logged since the
beginning of the enclosing `with-test-logging` form. An optional
pattern matches a single message of anything that has been logged since the
beginning of the enclosing `with-test-logging` form. An optional
second parameter restricts the match to log events with the specified
level: `:trace`, `:debug`, `:info`, `:warn`, `:error` or `:fatal`.

Note: by default `logged?` returns true only if there is exactly one
log line match. An optional third parameter can be specified to disable
this restriction.

### `event->map`

This function converts a LogEvent to a Clojure map of the kind
Expand Down
17 changes: 17 additions & 0 deletions test/puppetlabs/trapperkeeper/logging_test.clj
Original file line number Diff line number Diff line change
Expand Up @@ -37,6 +37,23 @@
(is (true? @done?))
(is (logged? #"test thread" :info))))))

(deftest with-test-logging-and-duplicate-log-lines
(testing "test-logging captures matches duplicate lines when specified"
(with-test-logging
(log/error "duplicate message")
(log/error "duplicate message")
(log/warn "duplicate message")
(log/warn "single message")
(testing "single line only match"
(is (not (logged? #"duplicate message"))) ;; original behavior of the fn, default behavior
(is (logged? #"duplicate message" :warn false)))
(testing "disabling single line match, enabling multiple line match"
(is (logged? #"duplicate message" :error true))
(is (logged? #"duplicate message" nil true))
(testing "still handles single matches"
(is (logged? #"single message" nil true))
(is (logged? #"single message" :warn true)))))))

(deftest test-logging-configuration
(testing "Calling `configure-logging!` with a logback.xml file"
(tk-logging/configure-logging! "./dev-resources/logging/logback-debug.xml")
Expand Down
16 changes: 10 additions & 6 deletions test/puppetlabs/trapperkeeper/testutils/logging.clj
Original file line number Diff line number Diff line change
Expand Up @@ -322,19 +322,23 @@

(s/defn ^{:always-validate true} logged?
([msg-or-pred] (logged? msg-or-pred nil))
([msg-or-pred maybe-level] (logged? msg-or-pred maybe-level false))
([msg-or-pred :- (s/conditional ifn? (s/pred ifn?)
string? s/Str
:else Pattern)
maybe-level :- (s/maybe (s/pred #(levels %)))]
maybe-level :- (s/maybe (s/pred #(levels %)))
disable-single-line-match-restriction :- s/Bool]
(let [match? (cond (ifn? msg-or-pred) msg-or-pred
(string? msg-or-pred) #(= msg-or-pred (:message %))
:else #(re-find msg-or-pred (:message %)))
one-element? #(and (seq %) (empty? (rest %)))
one-element-if-specified? #(if (and (seq %) (or disable-single-line-match-restriction (empty? (rest %))))
true
(println "\n`logged?` warning: multiple log line matches found, but this arity expects only one match, returning false. Found matches: " % "\n"))
correct-level? #(or (nil? maybe-level) (= maybe-level (:level %)))]
(->> (map event->map @*test-log-events*)
(filter correct-level?)
(filter match?)
(one-element?)))))
(one-element-if-specified?)))))

(defmethod clojure.test/assert-expr 'logged? [is-msg form]
;"Asserts that exactly one event in *test-log-events* has a message
Expand All @@ -344,10 +348,10 @@
;is specified, the message's keyword level (:info, :error, etc.) must
;also match. For example:
; (with-test-logging (log/info \"123\") (is (logged? #\"2\")))."
(assert (#{2 3} (count form)))
(let [[_ msg-or-pred level] form]
(assert (#{2 3 4} (count form)))
(let [[_ msg-or-pred level disable-single-line-restriction] form]
`(let [events# @@#'puppetlabs.trapperkeeper.testutils.logging/*test-log-events*]
(if-not (logged? ~msg-or-pred ~level)
(if-not (logged? ~msg-or-pred ~level ~disable-single-line-restriction)
(clojure.test/do-report
{:type :fail
:message ~is-msg
Expand Down

0 comments on commit c3e723d

Please sign in to comment.