telemere/src/taoensso/telemere/utils.cljc

462 lines
15 KiB
Text
Raw Normal View History

2024-03-28 15:33:58 +00:00
(ns taoensso.telemere.utils
2024-03-21 11:36:55 +00:00
"Misc utils useful for Telemere handlers, middleware, etc."
(:refer-clojure :exclude [newline])
(:require
2024-04-01 08:38:49 +00:00
[clojure.string :as str]
#?(:clj [clojure.java.io :as jio])
[taoensso.encore :as enc :refer [have have?]]))
2024-03-21 11:36:55 +00:00
(comment
(require '[taoensso.telemere :as tel])
(remove-ns 'taoensso.telemere.utils)
(:api (enc/interns-overview)))
;;;; Private
(enc/def* ^:no-doc upper-qn
"Private, don't use.
`:foo/bar` -> \"FOO/BAR\", etc."
{:tag #?(:clj 'String :cljs 'string)}
(enc/fmemoize (fn [x] (str/upper-case (enc/as-qname x)))))
(comment (upper-qn :foo/bar))
(enc/def* ^:no-doc format-level
"Private, don't use.
`:info` -> \"INFO\",
`5` -> \"LEVEL:5\", etc."
{:tag #?(:clj 'String :cljs 'string)}
(enc/fmemoize
(fn [x]
(if (keyword? x)
(upper-qn x)
(str "LEVEL:" x)))))
(comment (format-level :info))
(enc/def* ^:no-doc format-id
"Private, don't use.
`:foo.bar/baz` -> \"::baz\", etc."
{:tag #?(:clj 'String :cljs 'string)}
(enc/fmemoize
(fn [ns x]
(if (keyword? x)
(if (= (namespace x) ns)
(str "::" (name x))
(str x))
(str x)))))
(comment (format-id (str *ns*) ::id1))
;;;; Public misc
2024-04-05 13:32:03 +00:00
(enc/defaliases enc/newline enc/pr-edn #?(:cljs enc/pr-json))
2024-03-21 11:36:55 +00:00
#?(:clj (defn thread-name "Returns string name of current thread." ^String [] (.getName (Thread/currentThread))))
#?(:clj (defn thread-id "Returns long id of current thread." ^long [] (.getId (Thread/currentThread))))
(comment [(thread-name) (thread-id)])
#?(:clj
(defn host-ip
"Returns cached local host IP address string, or `timeout-val` (default \"UnknownHost\")."
( [timeout-msecs timeout-val] (enc/get-host-ip (enc/msecs :mins 1) timeout-msecs timeout-val))
(^String [ ] (enc/get-host-ip (enc/msecs :mins 1) 5000 "UnknownHost"))))
#?(:clj
(defn hostname
"Returns cached local hostname string, or `timeout-val` (default \"UnknownHost\")."
( [timeout-msecs timeout-val] (enc/get-hostname (enc/msecs :mins 1) timeout-msecs timeout-val))
(^String [ ] (enc/get-hostname (enc/msecs :mins 1) 3500 (delay (host-ip 1500 "UnknownHost"))))))
(comment (enc/qb 1e6 (hostname))) ; 56.88
#?(:cljs
(defn js-console-logger
"Returns JavaScript console logger to match given signal level:
`:trace` -> `js/console.trace`,
`:error` -> `js/console.error`, etc.
Defaults to `js.console.log` for unmatched signal levels.
2024-03-28 15:33:58 +00:00
NB: assumes that `js/console` exists, handler constructors should check first!"
2024-03-21 11:36:55 +00:00
[level]
(case level
:trace js/console.trace
:debug js/console.debug
:info js/console.info
:warn js/console.warn
:error js/console.error
:fatal js/console.error
:report js/console.info
(do js/console.log))))
(comment (js-console-logger))
(defn error-signal?
"Experimental, subject to change.
Returns true iff given signal has an `:error` value, or a `:kind` or `:level`
that indicates that it's an error."
2024-04-09 11:27:54 +00:00
#?(:cljs {:tag 'boolean})
2024-03-21 11:36:55 +00:00
[signal]
(and signal
(boolean
(or
(get signal :error)
(enc/identical-kw? (get signal :kind) :error)
(case (get signal :level) (:error :fatal) true false)
(get signal :error?) ; User kv
))))
(comment (error-signal? {:level :fatal}))
(defn error-in-signal->maps
"Experimental, subject to change.
Returns given signal with possible `:error` replaced by
[{:keys [type msg data]} ...] cause chain.
Useful when serializing signals to edn/JSON/etc."
[signal]
(enc/if-let [error (get signal :error)
chain (enc/ex-chain :as-map error)]
(assoc signal :error chain)
(do signal)))
(comment (error-in-signal->maps {:level :info :error (ex-info "Ex" {})}))
(defn minify-signal
"Experimental, subject to change.
Returns minimal signal map, removing:
- Keys with nil values, and
- Keys with redundant values (`:extra-kvs`, `:location`, `:file`).
Useful when serializing signals to edn/JSON/etc."
[signal]
(reduce-kv
(fn [m k v]
(if (nil? v)
m
(case k
(:extra-kvs :location :file) m
(assoc m k v))))
nil signal))
(comment
(minify-signal (tel/with-signal (tel/event! ::ev-id1)))
(let [s (tel/with-signal (tel/event! ::ev-id1))]
(enc/qb 1e6 ; 683
(minify-signal s))))
2024-04-01 08:38:49 +00:00
;;;; Files
#?(:clj (defn ^:no-doc as-file ^java.io.File [file] (jio/as-file file)))
#?(:clj
(defn ^:no-doc writeable-file!
"Private, don't use.
Returns writable `java.io.File`, or throws."
^java.io.File [file]
(let [file (as-file file)]
(when-not (.exists file)
(when-let [parent (.getParentFile file)] (.mkdirs parent))
(.createNewFile file))
(if (.canWrite file)
file
(throw
(ex-info "Unable to prepare writable `java.io.File`"
{:path (.getAbsolutePath file)}))))))
#?(:clj
(defn ^:no-doc file-stream
"Private, don't use.
Returns a new `java.io.FileOutputStream` for given `java.io.File`, etc."
^java.io.FileOutputStream [file append?]
(java.io.FileOutputStream. (as-file file) (boolean append?))))
#?(:clj
(defn file-writer
"Experimental, subject to change!!
Opens the specified file and returns a stateful fn of 2 arities:
[content] => Writes given content to file, or no-ops if closed.
[] => Closes the writer.
Thread safe. Automatically creates file and parent dirs as necessary.
Writers MUST ALWAYS be manually closed after use!
Useful for handlers that write to files, etc."
[file append?]
(let [file (writeable-file! file)
stream_ (volatile! (file-stream file append?))
open?_ (enc/latom true)
close!
(fn []
(when (compare-and-set! open?_ true false)
(when-let [^java.io.FileOutputStream stream (.deref stream_)]
(.close stream)
(vreset! stream_ nil)
true)))
reset!
(fn []
(close!)
(vreset! stream_ (file-stream file append?))
(reset! open?_ true)
true)
write-ba!
(fn [^bytes ba-content retrying?]
(when-let [^java.io.FileOutputStream stream (.deref stream_)]
(.write stream ba-content)
(.flush stream)
true))
file-exists!
(let [rl (enc/rate-limiter-once-per 250)]
(fn []
(or (rl) (.exists file)
(throw (java.io.IOException. "File doesn't exist")))))
lock (Object.)]
(fn file-writer
([] (when (open?_) (locking lock (close!))))
([content-or-action]
(case content-or-action ; Undocumented
:writer/open? (open?_)
:writer/file file
:writer/stream (.deref stream_)
:writer/reset! (locking lock (reset!))
(when (open?_)
(let [content content-or-action
ba (.getBytes (str content) java.nio.charset.StandardCharsets/UTF_8)]
(locking lock
(try
(file-exists!)
(write-ba! ba false)
(catch java.io.IOException _
(reset!)
(write-ba! ba true))))))))))))
(comment (def fw1 (file-writer "test.txt" true)) (fw1 "x") (fw1))
2024-03-21 11:36:55 +00:00
;;;; Formatters
(defn format-nsecs-fn
"Experimental, subject to change.
Returns a (fn format [nanosecs]) that:
- Takes a long nanoseconds (e.g. runtime).
- Returns a formatted human-readable string like:
\"1.00m\", \"4.20s\", \"340ms\", \"822μs\", etc."
([] (format-nsecs-fn nil))
([{:as _opts}] (fn format-nsecs [nanosecs] (enc/format-nsecs nanosecs))))
(comment ((format-nsecs-fn) 4747463567))
(enc/defalias enc/format-inst-fn)
(comment ((format-inst-fn) (enc/now-inst)))
(defn format-error-fn
"Experimental, subject to change.
Returns a (fn format [error]) that:
- Takes a platform error (`Throwable` or `js/Error`).
- Returns a formatted human-readable string"
([] (format-error-fn nil))
([{:as _opts}]
(let [nl enc/newline
nls enc/newlines]
(fn format-error [error]
(when-let [em (enc/ex-map error)]
(let [sb (enc/str-builder)
s+ (partial enc/sb-append sb)
{:keys [chain trace]} em]
2024-04-09 11:27:54 +00:00
(let [s+cause (enc/sb-appender sb (str nls "Caused: "))]
2024-03-21 11:36:55 +00:00
(s+ " Root: ")
(doseq [{:keys [type msg data]} (rseq chain)]
2024-04-09 11:27:54 +00:00
(s+cause type " - " msg)
2024-03-21 11:36:55 +00:00
(when data
(s+ nl " data: " (enc/pr-edn* data)))))
(when trace
(s+ nl nl "Root stack trace:")
#?(:cljs (s+ nl trace)
:clj
(doseq [st-el (force trace)]
(let [{:keys [class method file line]} st-el]
(s+ nl "" class "/" method " at " file ":" line)))))
(str sb)))))))
(comment
(do (throw (ex-info "Ex2" {:k2 "v2"} (ex-info "Ex1" {:k1 "v1"}))))
(do (enc/ex-map (ex-info "Ex2" {:k2 "v2"} (ex-info "Ex1" {:k1 "v1"}))))
(println (str "--\n" ((format-error-fn) (ex-info "Ex2" {:k2 "v2"} (ex-info "Ex1" {:k1 "v1"}))))))
(defn format-signal-prelude-fn
"Experimental, subject to change.
Returns a (fn format [signal]) that:
- Takes a Telemere signal.
- Returns a formatted prelude string like:
\"2024-03-26T11:14:51.806Z INFO EVENT Hostname taoensso.telemere(2,21) ::ev-id - msg\""
([] (format-signal-prelude-fn nil))
([{:keys [format-inst-fn]
:or {format-inst-fn (format-inst-fn)}}]
(fn format-signal-prelude [signal]
(let [{:keys [inst level kind ns id msg_]} signal
2024-04-09 11:27:54 +00:00
sb (enc/str-builder)
s+spc (enc/sb-appender sb " ")]
2024-03-21 11:36:55 +00:00
2024-04-09 11:27:54 +00:00
(when inst (when-let [ff format-inst-fn] (s+spc (ff inst))))
(when level (s+spc (format-level level)))
2024-03-21 11:36:55 +00:00
2024-04-09 11:27:54 +00:00
(if kind (s+spc (upper-qn kind)) (s+spc "DEFAULT"))
#?(:clj (s+spc (hostname)))
2024-03-21 11:36:55 +00:00
;; "<ns>:(<line>,<column>)"
(when-let [base (or ns (get signal :file))]
(let [s+ (partial enc/sb-append sb)] ; Without separator
(s+ " " base)
(when-let [l (get signal :line)]
(s+ "(" l)
(when-let [c (get signal :column)] (s+ "," c))
(s+ ")"))))
2024-04-09 11:27:54 +00:00
(when id (s+spc (format-id ns id)))
(when-let [msg (force msg_)] (s+spc "- " msg))
2024-03-21 11:36:55 +00:00
(str sb)))))
(comment ((format-signal-prelude-fn) (tel/with-signal (tel/event! ::ev-id))))
2024-04-04 14:12:44 +00:00
(defn ^:no-doc signal-content-handler
2024-03-21 11:36:55 +00:00
"Private, don't use.
Returns a (fn handle [signal handle-fn value-fn]) for internal use.
Content equivalent to `format-signal-prelude-fn`."
2024-04-04 14:12:44 +00:00
([] (signal-content-handler nil))
2024-03-21 11:36:55 +00:00
([{:keys [format-nsecs-fn format-error-fn raw-error?]
:or
{format-nsecs-fn (format-nsecs-fn) ; (fn [nanosecs])
format-error-fn (format-error-fn) ; (fn [error])
}}]
(let [err-start (str newline "<<< error <<<" newline)
err-stop (str newline ">>> error >>>")]
2024-04-04 14:12:44 +00:00
(fn a-signal-content-handler [signal hf vf]
2024-03-21 11:36:55 +00:00
(let [{:keys [uid parent data extra-kvs ctx sample-rate]} signal]
(when sample-rate (hf "sample: " (vf sample-rate)))
(when uid (hf " uid: " (vf uid)))
(when parent (hf "parent: " (vf parent)))
(when data (hf " data: " (vf data)))
(when extra-kvs (hf " kvs: " (vf extra-kvs)))
(when ctx (hf " ctx: " (vf ctx))))
(let [{:keys [run-form error]} signal]
(when run-form
(let [{:keys [run-val run-nsecs]} signal
run-time (when run-nsecs (when-let [ff format-nsecs-fn] (ff run-nsecs)))
run-info
(if error
{:form run-form
:time run-time
:nsecs run-nsecs}
{:form run-form
:time run-time
:nsecs run-nsecs
:val run-val
#?@(:clj [:val-type (enc/class-sym run-val)])})]
(hf " run: " (vf run-info))))
(when error
(if raw-error?
(hf " error: " error)
(when-let [ff format-error-fn]
(hf err-start (ff error) err-stop)))))))))
;;;; Signal formatters
(defn format-signal->edn-fn
"Experimental, subject to change.
Returns a (fn format->edn [signal]) that:
- Takes a Telemere signal.
- Returns edn string of the (minified) signal."
([] (format-signal->edn-fn nil))
([{:keys [pr-edn-fn prep-fn]
:or
{pr-edn-fn pr-edn
prep-fn (comp error-in-signal->maps minify-signal)}}]
(fn format-signal->edn [signal]
(let [signal* (if prep-fn (prep-fn signal) signal)]
(pr-edn-fn signal*)))))
(comment ((format-signal->edn-fn) {:level :info, :msg "msg"}))
(defn format-signal->json-fn
"Experimental, subject to change.
Returns a (fn format->json [signal]) that:
- Takes a Telemere signal.
2024-04-05 13:32:03 +00:00
- Returns JSON string of the (minified) signal.
(Clj only): An appropriate `:pr-json-fn` MUST be provided."
2024-03-21 11:36:55 +00:00
([] (format-signal->json-fn nil))
([{:keys [pr-json-fn prep-fn]
:or
2024-04-05 13:32:03 +00:00
{#?@(:cljs [pr-json-fn pr-json])
2024-03-21 11:36:55 +00:00
prep-fn (comp error-in-signal->maps minify-signal)}}]
2024-04-05 13:32:03 +00:00
(when-not pr-json-fn
(throw
(ex-info (str "No `" `format-signal->json-fn "` `:pr-json-fn` was provided") {})))
2024-03-21 11:36:55 +00:00
(fn format-signal->json [signal]
(let [signal* (if prep-fn (prep-fn signal) signal)]
(pr-json-fn signal*)))))
(comment ((format-signal->json-fn) {:level :info, :msg "msg"}))
(defn format-signal->str-fn
"Experimental, subject to change.
Returns a (fn format->str [signal]) that:
- Takes a Telemere signal.
- Returns a formatted string intended for text consoles, etc."
([] (format-signal->str-fn nil))
([{:keys [format-signal-prelude-fn
format-nsecs-fn format-error-fn]
:or
{format-signal-prelude-fn (format-signal-prelude-fn) ; (fn [signal])
format-nsecs-fn (format-nsecs-fn) ; (fn [nanosecs])
format-error-fn (format-error-fn) ; (fn [error])
}}]
2024-04-04 14:12:44 +00:00
(let [signal-content-handler ; (fn [signal hf vf]
(signal-content-handler
2024-03-21 11:36:55 +00:00
{:format-nsecs-fn format-nsecs-fn
:format-error-fn format-error-fn})]
(fn format-signal->str [signal]
(let [sb (enc/str-builder)
s+ (partial enc/sb-append sb)
s++ (partial enc/sb-append sb (str newline " "))]
(when-let [ff format-signal-prelude-fn] (s+ (ff signal))) ; Prelude
2024-04-09 11:27:54 +00:00
(signal-content-handler signal s++ enc/pr-edn*) ; Content
2024-03-21 11:36:55 +00:00
(str sb))))))
(comment
(tel/with-ctx {:c :C}
(println
((format-signal->str-fn)
(tel/with-signal
(tel/event! ::ev-id
{:user-k1 #{:a :b :c}
:msg "hi"
:data {:a :A}
;; :error (ex-info "Ex2" {:k2 "v2"} (ex-info "Ex1" {:k1 "v1"}))
:run (/ 1 0)}))))))