YII2 : cant get traceId in logMessage

[runtu666]

code :

<?php

namespace app\components;

use yii\helpers\VarDumper;
use yii\log\FileTarget;

class JsonLogTarget extends FileTarget
{
    public function export(): void
    {
        foreach ($this->messages as $message) {
            list($text, $level, $category, $timestamp) = $message;
            if (!is_string($text)) {
                if ($text instanceof \Throwable) {
                    $text = (string)$text;
                } else {
                    $text = VarDumper::export($text);
                }
            }
            $log = [
                'timestamp' => $timestamp,
                'level' => $level,
                'category' => $category,
                'message' => $text,
                'trace' => $message[4] ?? null,  // 如果有堆栈信息
            ];
            $span = \OpenTelemetry\API\Trace\Span::getCurrent();
            $log['traceId'] = $span->getContext()->getTraceId();
            $log['spanId'] = $span->getContext()->getSpanId();
            $text = json_encode($log) . PHP_EOL;
            file_put_contents('php://stdout', $text);
        }
    }
}

output:
{"timestamp":1737686232.099166,"level":1,"category":"application","message":"test","trace":[{"file":"\/var\/www\/html\/controllers\/SiteController.php","line":68,"function":"error","class":"yii\\BaseYii","type":"::"}],"traceId":"00000000000000000000000000000000","spanId":"0000000000000000"}

why the traceId and spanId is 000000...

[brettmc]

That looks like it should work. Can you confirm that you have an active span at the time that the log was generated? It's important that it's active, since Span::getCurrent() fetches the active span from context, eg:

$span = $tracer->spanBuilder('test');
var_dump(Span::getCurrent()->getContext()->getTraceId()); //all 0's
$scope = $span->activate();
var_dump(Span::getCurrent()->getContext()->getTraceId()); //a trace id
$logger->log('test');
$scope->detach();
$span->end();

[runtu666]

i can get a trace id in controller.

But I want to write each traceId to the log, so I implemented
The export method of the yii\log\Target class cannot get the traceId.

@brettmc

[runtu666]

Show you my code:
controller:

logger:

output:

why it can get traceId in controller, cant get in logger?

[brettmc]

Looking at Yii's documentation, I think your issue is that logs are collected in memory, then only flushed when a request finishes or the buffer is full.

When the logger object flushes log messages to log targets, they do not get exported immediately. Instead, the message exporting only occurs when a log target accumulates certain number of the filtered messages.

That means that your code in export (eg $span->getContext()->getTraceId()) is running at shutdown, not when the log was created, and so there is no longer an active span.

[runtu666]

So, How can I write traceId into log with yii2?

[brettmc]

So, How can I write traceId into log with yii2?

If you're willing to try out auto-instrumentation, our psr-3 auto-instrumentation does what you want: https://github.com/open-telemetry/opentelemetry-php-contrib/blob/main/src/Instrumentation/Psr3/tests/phpt/inject_yii.phpt

If you want to know how to do it with your current approach, you might need to ask this question in the yii2 support/help place. The question you need answered is how you can modify a log record immediately, rather than when they are flushed.