Bluemage/go/server/interceptor.go

package server

import (
	"context"
	"fmt"
	"log/slog"
	"time"

	"connectrpc.com/connect"
	"github.com/tigorlazuardi/bluemage/go/pkg/errs"
	"github.com/tigorlazuardi/bluemage/go/pkg/telemetry"
	"go.opentelemetry.io/otel/trace"
)

func LogInterceptor() connect.UnaryInterceptorFunc {
	interceptor := func(next connect.UnaryFunc) connect.UnaryFunc {
		return func(ctx context.Context, ar connect.AnyRequest) (resp connect.AnyResponse, err error) {
			span := trace.SpanFromContext(ctx)
			defer func() { telemetry.EndWithStatus(span, err) }()

			start := time.Now()
			resp, err = next(ctx, ar)
			dur := time.Since(start)
			durFloat := float64(dur) / float64(time.Second)
			if err != nil {
				slog.ErrorContext(ctx, "RPC Error",
					"procedure", ar.Spec().Procedure,
					"method", ar.HTTPMethod(),
					"duration", fmt.Sprintf("%.3fs", durFloat),
					"error", errs.DrillToError(err),
					"span.id", span.SpanContext().SpanID().String(),
					"trace.id", span.SpanContext().TraceID().String(),
				)
			} else {
				slog.InfoContext(ctx, "RPC Call",
					"procedure", ar.Spec().Procedure,
					"method", ar.HTTPMethod(),
					"duration", fmt.Sprintf("%.3fs", durFloat),
					"span.id", span.SpanContext().SpanID().String(),
					"trace.id", span.SpanContext().TraceID().String(),
				)
			}

			return resp, err
		}
	}
	return connect.UnaryInterceptorFunc(interceptor)
}