test(trace): add span log

Author: ycdzj

src/interceptor/tracing-user.interceptor.spec.ts

@@ -76,4 +76,4 @@ describe('TracingUserInterceptor', () => {
 
     expect(mockCallHandler.handle).toHaveBeenCalled();
   });
-});
+});

src/interceptor/tracing-user.interceptor.ts

@@ -3,20 +3,41 @@ import {
   NestInterceptor,
   ExecutionContext,
   CallHandler,
+  Logger,
 } from '@nestjs/common';
 import { Observable } from 'rxjs';
 import { trace } from '@opentelemetry/api';
 
 @Injectable()
 export class TracingUserInterceptor implements NestInterceptor {
+  private readonly logger = new Logger(TracingUserInterceptor.name);
+
   intercept(context: ExecutionContext, next: CallHandler): Observable<any> {
     const request = context.switchToHttp().getRequest();
     const userId = request.user?.id;
     const activeSpan = trace.getActiveSpan();
-    if (activeSpan && userId) {
-      activeSpan.setAttribute('user.id', userId);
+
+    this.logger.log(
+      `Interceptor called - userId: ${userId}, hasSpan: ${!!activeSpan}, url: ${request.url}`,
+    );
+
+    if (activeSpan) {
+      if (userId) {
+        activeSpan.setAttribute('user.id', userId);
+        this.logger.log(`Added user.id attribute to span: ${userId}`);
+      } else {
+        this.logger.warn('No userId found in request.user');
+      }
+
+      // Log span details
+      const spanContext = activeSpan.spanContext();
+      this.logger.log(
+        `Span context - traceId: ${spanContext.traceId}, spanId: ${spanContext.spanId}`,
+      );
+    } else {
+      this.logger.warn('No active span found');
     }
+
     return next.handle();
   }
 }
-

src/middlewares/tracing-user.middleware.spec.ts

@@ -62,4 +62,4 @@ describe('TracingUserMiddleware', () => {
 
     expect(next).toHaveBeenCalled();
   });
-});
+});