Skip to main content

linera_service/tracing/
mod.rs

1// Copyright (c) Zefchain Labs, Inc.
2// SPDX-License-Identifier: Apache-2.0
3
4//! This module provides unified handling for tracing subscribers within Linera binaries.
5
6/// Support for emitting traces in the Chrome tracing format.
7pub mod chrome;
8pub mod opentelemetry;
9
10use std::{
11    env,
12    fs::{File, OpenOptions},
13    path::Path,
14    sync::Arc,
15};
16
17use is_terminal::IsTerminal as _;
18use tracing::Subscriber;
19use tracing_subscriber::{
20    fmt::{
21        self,
22        format::{FmtSpan, Format, Full},
23        time::FormatTime,
24        FormatFields, MakeWriter,
25    },
26    layer::{Layer, SubscriberExt as _},
27    registry::LookupSpan,
28    util::SubscriberInitExt,
29    EnvFilter,
30};
31#[cfg(not(target_arch = "wasm32"))]
32use {
33    ::opentelemetry::trace::TraceContextExt as _, tracing_opentelemetry::OtelData,
34    tracing_subscriber::fmt::FormatEvent,
35};
36
37pub(crate) struct EnvConfig {
38    pub(crate) env_filter: EnvFilter,
39    span_events: FmtSpan,
40    format: Option<String>,
41    color_output: bool,
42    log_name: String,
43}
44
45impl EnvConfig {
46    pub(crate) fn stderr_layer<S>(&self) -> Box<dyn Layer<S> + Send + Sync>
47    where
48        S: Subscriber + for<'span> LookupSpan<'span>,
49    {
50        prepare_formatted_layer(
51            self.format.as_deref(),
52            fmt::layer()
53                .with_span_events(self.span_events.clone())
54                .with_writer(std::io::stderr)
55                .with_ansi(self.color_output),
56        )
57    }
58
59    pub(crate) fn maybe_log_file_layer<S>(&self) -> Option<Box<dyn Layer<S> + Send + Sync>>
60    where
61        S: Subscriber + for<'span> LookupSpan<'span>,
62    {
63        open_log_file(&self.log_name).map(|file_writer| {
64            prepare_formatted_layer(
65                self.format.as_deref(),
66                fmt::layer()
67                    .with_span_events(self.span_events.clone())
68                    .with_writer(Arc::new(file_writer))
69                    .with_ansi(false),
70            )
71        })
72    }
73}
74
75/// Initializes tracing in a standard way.
76///
77/// The environment variables `RUST_LOG`, `RUST_LOG_SPAN_EVENTS`, and `RUST_LOG_FORMAT`
78/// can be used to control the verbosity, the span event verbosity, and the output format,
79/// respectively.
80///
81/// The `LINERA_LOG_DIR` environment variable can be used to configure a directory to
82/// store log files. If it is set, a file named `log_name` with the `log` extension is
83/// created in the directory.
84pub fn init(log_name: &str) {
85    let config = get_env_config(log_name);
86    let maybe_log_file_layer = config.maybe_log_file_layer();
87    let stderr_layer = config.stderr_layer();
88
89    tracing_subscriber::registry()
90        .with(config.env_filter)
91        .with(maybe_log_file_layer)
92        .with(stderr_layer)
93        .init();
94}
95
96pub(crate) fn get_env_config(log_name: &str) -> EnvConfig {
97    let env_filter = EnvFilter::builder()
98        .with_default_directive(tracing_subscriber::filter::LevelFilter::INFO.into())
99        .from_env_lossy();
100
101    let span_events = std::env::var("RUST_LOG_SPAN_EVENTS")
102        .ok()
103        .map_or(FmtSpan::NONE, |s| fmt_span_from_str(&s));
104
105    let format = std::env::var("RUST_LOG_FORMAT").ok();
106    let color_output =
107        !std::env::var("NO_COLOR").is_ok_and(|x| !x.is_empty()) && std::io::stderr().is_terminal();
108
109    EnvConfig {
110        env_filter,
111        span_events,
112        format,
113        color_output,
114        log_name: log_name.to_string(),
115    }
116}
117
118/// Opens a log file for writing.
119///
120/// The location of the file is determined by the `LINERA_LOG_DIR` environment variable,
121/// and its name by the `log_name` parameter.
122///
123/// Returns [`None`] if the `LINERA_LOG_DIR` environment variable is not set.
124pub(crate) fn open_log_file(log_name: &str) -> Option<File> {
125    let log_directory = env::var_os("LINERA_LOG_DIR")?;
126    let mut log_file_path = Path::new(&log_directory).join(log_name);
127    log_file_path.set_extension("log");
128
129    Some(
130        OpenOptions::new()
131            .append(true)
132            .create(true)
133            .open(log_file_path)
134            .expect("Failed to open log file for writing"),
135    )
136}
137
138#[cfg(not(target_arch = "wasm32"))]
139struct WithTraceContext;
140
141#[cfg(not(target_arch = "wasm32"))]
142impl<S, N> FormatEvent<S, N> for WithTraceContext
143where
144    S: Subscriber + for<'span> LookupSpan<'span>,
145    N: for<'writer> FormatFields<'writer> + 'static,
146{
147    fn format_event(
148        &self,
149        ctx: &fmt::FmtContext<'_, S, N>,
150        mut writer: fmt::format::Writer<'_>,
151        event: &tracing::Event<'_>,
152    ) -> std::fmt::Result {
153        if let Some(scope) = ctx.event_scope() {
154            for span in scope {
155                let extensions = span.extensions();
156                if let Some(otel_data) = extensions.get::<OtelData>() {
157                    // For root spans, trace_id is on the builder.
158                    // For child spans, it's inherited from the parent context.
159                    let trace_id = otel_data
160                        .builder
161                        .trace_id
162                        .unwrap_or_else(|| otel_data.parent_cx.span().span_context().trace_id());
163                    if trace_id != ::opentelemetry::trace::TraceId::INVALID {
164                        write!(writer, "traceID={trace_id} ")?;
165                    }
166                    if let Some(span_id) = otel_data.builder.span_id {
167                        write!(writer, "spanID={span_id} ")?;
168                    }
169                    break;
170                }
171            }
172        }
173        Format::default().format_event(ctx, writer, event)
174    }
175}
176
177/// Applies a requested `formatting` to the log output of the provided `layer`.
178///
179/// Returns a boxed [`Layer`] with the formatting applied to the original `layer`.
180pub(crate) fn prepare_formatted_layer<S, N, W, T>(
181    formatting: Option<&str>,
182    layer: fmt::Layer<S, N, Format<Full, T>, W>,
183) -> Box<dyn Layer<S> + Send + Sync>
184where
185    S: Subscriber + for<'span> LookupSpan<'span>,
186    N: for<'writer> FormatFields<'writer> + Send + Sync + 'static,
187    W: for<'writer> MakeWriter<'writer> + Send + Sync + 'static,
188    T: FormatTime + Send + Sync + 'static,
189{
190    match formatting.unwrap_or("plain") {
191        "json" => layer.json().boxed(),
192        "pretty" => layer.pretty().boxed(),
193        "plain" => {
194            #[cfg(not(target_arch = "wasm32"))]
195            {
196                layer.event_format(WithTraceContext).boxed()
197            }
198            #[cfg(target_arch = "wasm32")]
199            {
200                layer.boxed()
201            }
202        }
203        format => {
204            panic!("Invalid RUST_LOG_FORMAT: `{format}`.  Valid values are `json` or `pretty`.")
205        }
206    }
207}
208
209pub(crate) fn fmt_span_from_str(events: &str) -> FmtSpan {
210    let mut fmt_span = FmtSpan::NONE;
211    for event in events.split(',') {
212        fmt_span |= match event {
213            "new" => FmtSpan::NEW,
214            "enter" => FmtSpan::ENTER,
215            "exit" => FmtSpan::EXIT,
216            "close" => FmtSpan::CLOSE,
217            "active" => FmtSpan::ACTIVE,
218            "full" => FmtSpan::FULL,
219            _ => FmtSpan::NONE,
220        };
221    }
222    fmt_span
223}