Skip to content
2 changes: 2 additions & 0 deletions CHANGELOG.md
Original file line number Diff line number Diff line change
Expand Up @@ -12,6 +12,8 @@ and this project adheres to [Semantic Versioning](https://semver.org/spec/v2.0.0

## Unreleased

- logs: add exception support to Logger emit and LogRecord attributes
([#4907](https://github.com/open-telemetry/opentelemetry-python/issues/4907))
- Fix intermittent CI failures in `getting-started` and `tracecontext` jobs caused by GitHub git CDN SHA propagation lag by installing contrib packages from the already-checked-out local copy instead of a second git clone
([#4958](https://github.com/open-telemetry/opentelemetry-python/pull/4958))
- `opentelemetry-sdk`: fix type annotations on `MetricReader` and related types
Expand Down
11 changes: 11 additions & 0 deletions opentelemetry-api/src/opentelemetry/_logs/_internal/__init__.py
Original file line number Diff line number Diff line change
Expand Up @@ -76,6 +76,7 @@ def __init__(
body: AnyValue = None,
attributes: Optional[_ExtendedAttributes] = None,
event_name: Optional[str] = None,
exception: Optional[BaseException] = None,
) -> None: ...

@overload
Expand All @@ -94,6 +95,7 @@ def __init__(
severity_number: Optional[SeverityNumber] = None,
body: AnyValue = None,
attributes: Optional[_ExtendedAttributes] = None,
exception: Optional[BaseException] = None,
Copy link
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

This overload is deprecated

Suggested change
exception: Optional[BaseException] = None,

) -> None: ...

def __init__(
Expand All @@ -110,6 +112,7 @@ def __init__(
body: AnyValue = None,
attributes: Optional[_ExtendedAttributes] = None,
event_name: Optional[str] = None,
exception: Optional[BaseException] = None,
) -> None:
if not context:
context = get_current()
Expand All @@ -127,6 +130,7 @@ def __init__(
self.body = body
self.attributes = attributes
self.event_name = event_name
self.exception = exception


class Logger(ABC):
Expand Down Expand Up @@ -157,6 +161,7 @@ def emit(
body: AnyValue | None = None,
attributes: _ExtendedAttributes | None = None,
event_name: str | None = None,
exception: BaseException | None = None,
) -> None: ...

@overload
Expand All @@ -178,6 +183,7 @@ def emit(
body: AnyValue | None = None,
attributes: _ExtendedAttributes | None = None,
event_name: str | None = None,
exception: BaseException | None = None,
) -> None:
"""Emits a :class:`LogRecord` representing a log to the processing pipeline."""

Expand All @@ -200,6 +206,7 @@ def emit(
body: AnyValue | None = None,
attributes: _ExtendedAttributes | None = None,
event_name: str | None = None,
exception: BaseException | None = None,
) -> None: ...

@overload
Expand All @@ -220,6 +227,7 @@ def emit(
body: AnyValue | None = None,
attributes: _ExtendedAttributes | None = None,
event_name: str | None = None,
exception: BaseException | None = None,
) -> None:
pass

Expand Down Expand Up @@ -266,6 +274,7 @@ def emit(
body: AnyValue | None = None,
attributes: _ExtendedAttributes | None = None,
event_name: str | None = None,
exception: BaseException | None = None,
) -> None: ...

@overload
Expand All @@ -286,6 +295,7 @@ def emit(
body: AnyValue | None = None,
attributes: _ExtendedAttributes | None = None,
event_name: str | None = None,
exception: BaseException | None = None,

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

nit: When record is provided alongside an exception kwarg, the exception is silently dropped here (only forwarded in the else branch). The SDK's Logger.emit() explicitly handles both (exception or getattr(record, "exception", None)), so there's a subtle inconsistency between the proxy and SDK paths.

Not a contract violation (the overloads define them as separate call forms), but it might be worth either forwarding exception here too (self._logger.emit(record, exception=exception)) or adding a comment explaining why it's intentionally omitted.

) -> None:
if record:
self._logger.emit(record)
Expand All @@ -299,6 +309,7 @@ def emit(
body=body,
attributes=attributes,
event_name=event_name,
exception=exception,
)


Expand Down
5 changes: 5 additions & 0 deletions opentelemetry-api/tests/logs/test_log_record.py
Original file line number Diff line number Diff line change
Expand Up @@ -25,3 +25,8 @@ class TestLogRecord(unittest.TestCase):
def test_log_record_observed_timestamp_default(self, time_ns_mock): # type: ignore
time_ns_mock.return_value = OBSERVED_TIMESTAMP
self.assertEqual(LogRecord().observed_timestamp, OBSERVED_TIMESTAMP)

def test_log_record_exception(self):
exc = ValueError("boom")
log_record = LogRecord(exception=exc)
self.assertIs(log_record.exception, exc)
1 change: 1 addition & 0 deletions opentelemetry-api/tests/logs/test_proxy.py
Original file line number Diff line number Diff line change
Expand Up @@ -46,6 +46,7 @@ def emit(
body=None,
attributes=None,
event_name=None,
exception: typing.Optional[BaseException] = None,
) -> None:
pass

Expand Down
Original file line number Diff line number Diff line change
Expand Up @@ -514,6 +514,50 @@ def force_flush(self, timeout_millis: int = 30000) -> bool:
)


def _get_exception_attributes(
exception: BaseException,
) -> dict[str, AnyValue]:
stacktrace = "".join(
traceback.format_exception(
type(exception), value=exception, tb=exception.__traceback__
)
)
module = type(exception).__module__
qualname = type(exception).__qualname__
exception_type = (
f"{module}.{qualname}" if module and module != "builtins" else qualname
)
return {
exception_attributes.EXCEPTION_TYPE: exception_type,
exception_attributes.EXCEPTION_MESSAGE: str(exception),
exception_attributes.EXCEPTION_STACKTRACE: stacktrace,
}


def _apply_exception_attributes(
log_record: LogRecord,
exception: BaseException | None,
) -> None:
if exception is None:
return

exception_attributes_map = _get_exception_attributes(exception)
attributes = log_record.attributes
if attributes:
if isinstance(attributes, BoundedAttributes):
for key, value in exception_attributes_map.items():
if key not in attributes:
attributes[key] = value
return
Comment on lines +547 to +551
Copy link
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

What's the reason for this branch?

merged = dict(attributes)
for key, value in exception_attributes_map.items():
merged.setdefault(key, value)
log_record.attributes = merged
return

log_record.attributes = exception_attributes_map
Comment on lines +545 to +558
Copy link
Contributor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

nit:

Suggested change
attributes = log_record.attributes
if attributes:
if isinstance(attributes, BoundedAttributes):
for key, value in exception_attributes_map.items():
if key not in attributes:
attributes[key] = value
return
merged = dict(attributes)
for key, value in exception_attributes_map.items():
merged.setdefault(key, value)
log_record.attributes = merged
return
log_record.attributes = exception_attributes_map
attributes = log_record.attributes or {}
if isinstance(attributes, BoundedAttributes):
for key, value in exception_attributes_map.items():
if key not in attributes:
attributes[key] = value
return
log_record.attributes = {
**exception_attributes_map,
**attributes,
}

Copy link
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Since we're 3.9 plus, I think a | b is recommended. at least we've been doing that in GenAI. I believe it calls into native code so shoudl be much quicker



class LoggingHandler(logging.Handler):
"""A handler class which writes logging records, in OTLP format, to
a network destination or file. Supports signals from the `logging` module.
Expand Down Expand Up @@ -666,20 +710,32 @@ def emit(
body: AnyValue | None = None,
attributes: _ExtendedAttributes | None = None,
event_name: str | None = None,
exception: BaseException | None = None,
) -> None:
"""Emits the :class:`ReadWriteLogRecord` by setting instrumentation scope
and forwarding to the processor.
"""
# If a record is provided, use it directly
if record is not None:
record_exception = exception or getattr(record, "exception", None)
Copy link
Contributor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Personally, I'm not a huge fan of modifying attributes of an already created log record. For example, if the attributes in the created log record are immutable, the _apply_exception_attributes function will raise an exception at runtime.

if record_exception is None and isinstance(
record, ReadWriteLogRecord
):
record_exception = getattr(
record.log_record, "exception", None
)
if not isinstance(record, ReadWriteLogRecord):
_apply_exception_attributes(record, record_exception)
# pylint:disable=protected-access
writable_record = ReadWriteLogRecord._from_api_log_record(
record=record,
resource=self._resource,
instrumentation_scope=self._instrumentation_scope,
)
else:
_apply_exception_attributes(
record.log_record, record_exception
)
writable_record = record
else:
# Create a record from individual parameters
Expand All @@ -692,7 +748,9 @@ def emit(
body=body,
attributes=attributes,
event_name=event_name,
exception=exception,
)
_apply_exception_attributes(log_record, exception)
Copy link
Contributor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

nit: If we're creating a log record from scratch (as we are here), we should be able to directly modify the attributes before constructing the record.

# pylint:disable=protected-access
writable_record = ReadWriteLogRecord._from_api_log_record(
record=log_record,
Expand Down
64 changes: 64 additions & 0 deletions opentelemetry-sdk/tests/logs/test_logs.py
Original file line number Diff line number Diff line change
Expand Up @@ -23,6 +23,7 @@
Logger,
LoggerProvider,
ReadableLogRecord,
ReadWriteLogRecord,
)
from opentelemetry.sdk._logs._internal import (
NoOpLogger,
Expand All @@ -31,6 +32,7 @@
from opentelemetry.sdk.environment_variables import OTEL_SDK_DISABLED
from opentelemetry.sdk.resources import Resource
from opentelemetry.sdk.util.instrumentation import InstrumentationScope
from opentelemetry.semconv.attributes import exception_attributes


class TestLoggerProvider(unittest.TestCase):
Expand Down Expand Up @@ -214,3 +216,65 @@ def test_can_emit_with_keywords_arguments(self):
self.assertEqual(result_log_record.attributes, {"some": "attributes"})
self.assertEqual(result_log_record.event_name, "event_name")
self.assertEqual(log_data.resource, logger.resource)

def test_emit_with_exception_adds_attributes(self):
logger, log_record_processor_mock = self._get_logger()
exc = ValueError("boom")

logger.emit(body="a log line", exception=exc)
log_record_processor_mock.on_emit.assert_called_once()
log_data = log_record_processor_mock.on_emit.call_args.args[0]
attributes = dict(log_data.log_record.attributes)
self.assertEqual(
attributes[exception_attributes.EXCEPTION_TYPE], "ValueError"
)
self.assertEqual(
attributes[exception_attributes.EXCEPTION_MESSAGE], "boom"
)
self.assertIn(
"ValueError: boom",
attributes[exception_attributes.EXCEPTION_STACKTRACE],

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

nit: All tests create exceptions without raising them, so __traceback__ is None and traceback.format_exception() produces minimal output with no actual stack frames. Consider adding at least one test that raises and catches an exception to verify real stacktrace formatting:

def test_emit_with_raised_exception_has_stacktrace(self):
    logger, log_record_processor_mock = self._get_logger()
    try:
        raise ValueError("boom")
    except ValueError as exc:
        logger.emit(body="error", exception=exc)
    log_data = log_record_processor_mock.on_emit.call_args.args[0]
    stacktrace = dict(log_data.log_record.attributes)[exception_attributes.EXCEPTION_STACKTRACE]
    self.assertIn("Traceback (most recent call last)", stacktrace)
    self.assertIn("raise ValueError", stacktrace)

)

def test_emit_logrecord_exception_preserves_user_attributes(self):
logger, log_record_processor_mock = self._get_logger()
exc = ValueError("boom")
log_record = LogRecord(
observed_timestamp=0,
body="a log line",
attributes={exception_attributes.EXCEPTION_TYPE: "custom"},
exception=exc,
)

logger.emit(log_record)
log_record_processor_mock.on_emit.assert_called_once()
log_data = log_record_processor_mock.on_emit.call_args.args[0]
attributes = dict(log_data.log_record.attributes)
self.assertEqual(
attributes[exception_attributes.EXCEPTION_TYPE], "custom"
)
self.assertEqual(
attributes[exception_attributes.EXCEPTION_MESSAGE], "boom"
)

def test_emit_readwrite_logrecord_uses_exception(self):
logger, log_record_processor_mock = self._get_logger()
exc = RuntimeError("kaput")
log_record = LogRecord(
observed_timestamp=0,
body="a log line",
exception=exc,
)
readwrite = ReadWriteLogRecord(
log_record=log_record,
resource=Resource.create({}),
instrumentation_scope=logger._instrumentation_scope,
)

logger.emit(readwrite)
log_record_processor_mock.on_emit.assert_called_once()
log_data = log_record_processor_mock.on_emit.call_args.args[0]
attributes = dict(log_data.log_record.attributes)
self.assertEqual(
attributes[exception_attributes.EXCEPTION_TYPE], "RuntimeError"
)
Loading