dingtalk-workspace-cli/internal/logging/transport_test.go

// Copyright 2026 Alibaba Group
// Licensed under the Apache License, Version 2.0 (the "License");
// you may not use this file except in compliance with the License.
// You may obtain a copy of the License at
//
//     http://www.apache.org/licenses/LICENSE-2.0
//
// Unless required by applicable law or agreed to in writing, software
// distributed under the License is distributed on an "AS IS" BASIS,
// WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
// See the License for the specific language governing permissions and
// limitations under the License.

package logging

import (
	"bytes"
	"errors"
	"log/slog"
	"strings"
	"testing"
	"time"
)

func TestLogRequestWritesStructuredEntry(t *testing.T) {
	t.Parallel()

	var buf bytes.Buffer
	logger := slog.New(slog.NewJSONHandler(&buf, &slog.HandlerOptions{Level: slog.LevelDebug}))

	LogRequest(logger, "tools/call", "https://mcp.dingtalk.com/api?token=secret", "exec-123", 256)

	out := buf.String()
	if !strings.Contains(out, "jsonrpc_request") {
		t.Error("missing message 'jsonrpc_request'")
	}
	if !strings.Contains(out, "tools/call") {
		t.Error("missing method")
	}
	if !strings.Contains(out, "exec-123") {
		t.Error("missing execution_id")
	}
	// Query should be stripped
	if strings.Contains(out, "token=secret") {
		t.Error("endpoint query params should be redacted")
	}
}

func TestLogResponseSuccess(t *testing.T) {
	t.Parallel()

	var buf bytes.Buffer
	logger := slog.New(slog.NewJSONHandler(&buf, &slog.HandlerOptions{Level: slog.LevelDebug}))

	LogResponse(logger, "tools/call", "https://mcp.dingtalk.com/api", "exec-1", 200, 1024, 150*time.Millisecond, nil)

	out := buf.String()
	if !strings.Contains(out, "jsonrpc_response") {
		t.Error("missing message")
	}
	if !strings.Contains(out, "DEBUG") {
		t.Error("success should be DEBUG level")
	}
	if strings.Contains(out, "error") {
		t.Error("success response should not contain error field")
	}
}

func TestLogResponseError(t *testing.T) {
	t.Parallel()

	var buf bytes.Buffer
	logger := slog.New(slog.NewJSONHandler(&buf, &slog.HandlerOptions{Level: slog.LevelDebug}))

	LogResponse(logger, "initialize", "https://mcp.dingtalk.com", "exec-2", 500, 0, 2*time.Second, errors.New("connection refused"))

	out := buf.String()
	if !strings.Contains(out, "WARN") {
		t.Error("error response should be WARN level")
	}
	if !strings.Contains(out, "connection refused") {
		t.Error("error message missing")
	}
}

func TestLogRequestNilLogger(t *testing.T) {
	t.Parallel()
	// Should not panic
	LogRequest(nil, "test", "http://localhost", "", 0)
	LogResponse(nil, "test", "http://localhost", "", 200, 0, 0, nil)
	LogRequestBody(nil, "tools/call", "exec-1", "tool", nil)
	LogResponseBody(nil, "tools/call", "exec-1", 200, nil, "")
	LogRetryAttempt(nil, "tools/call", "exec-1", 0, 2, 429, 0, nil)
	LogErrorClassified(nil, "tools/call", "exec-1", "api", "timeout", 0, 0, true, "")
	LogCommandStart(nil, "exec-1", "doc", "list", "https://mcp.example.com", "1.0.0", false, 0)
	LogCommandEnd(nil, "exec-1", "doc", "list", true, 0, "", "")
}

func TestLogRequestBody(t *testing.T) {
	t.Parallel()
	var buf bytes.Buffer
	logger := slog.New(slog.NewJSONHandler(&buf, &slog.HandlerOptions{Level: slog.LevelDebug}))

	args := map[string]any{"name": "test", "limit": 10}
	LogRequestBody(logger, "tools/call", "exec-1", "doc.list", args)

	out := buf.String()
	if !strings.Contains(out, "jsonrpc_request_body") {
		t.Error("missing message")
	}
	if !strings.Contains(out, "doc.list") {
		t.Error("missing tool_name")
	}
	if !strings.Contains(out, "exec-1") {
		t.Error("missing execution_id")
	}
}

func TestLogRequestBody_SkipsNonToolsCall(t *testing.T) {
	t.Parallel()
	var buf bytes.Buffer
	logger := slog.New(slog.NewJSONHandler(&buf, &slog.HandlerOptions{Level: slog.LevelDebug}))

	LogRequestBody(logger, "initialize", "exec-1", "", nil)
	if buf.Len() != 0 {
		t.Error("should not log body for non-tools/call methods")
	}
}

func TestLogResponseBody(t *testing.T) {
	t.Parallel()
	var buf bytes.Buffer
	logger := slog.New(slog.NewJSONHandler(&buf, &slog.HandlerOptions{Level: slog.LevelDebug}))

	LogResponseBody(logger, "tools/call", "exec-1", 500, []byte(`{"error":"fail"}`), "trace-abc")

	out := buf.String()
	if !strings.Contains(out, "jsonrpc_response_body") {
		t.Error("missing message")
	}
	if !strings.Contains(out, "trace-abc") {
		t.Error("missing trace_id")
	}
	if !strings.Contains(out, "WARN") {
		t.Error("expected WARN level for 500 status")
	}
}

func TestLogRetryAttempt(t *testing.T) {
	t.Parallel()
	var buf bytes.Buffer
	logger := slog.New(slog.NewJSONHandler(&buf, &slog.HandlerOptions{Level: slog.LevelDebug}))

	LogRetryAttempt(logger, "tools/call", "exec-1", 0, 2, 429, 10*time.Millisecond, errors.New("rate limited"))

	out := buf.String()
	if !strings.Contains(out, "jsonrpc_retry") {
		t.Error("missing message")
	}
	if !strings.Contains(out, "rate limited") {
		t.Error("missing error")
	}
}

func TestLogErrorClassified(t *testing.T) {
	t.Parallel()
	var buf bytes.Buffer
	logger := slog.New(slog.NewJSONHandler(&buf, &slog.HandlerOptions{Level: slog.LevelDebug}))

	LogErrorClassified(logger, "tools/call", "exec-1", "auth", "http_401", 401, 0, false, "trace-xyz")

	out := buf.String()
	if !strings.Contains(out, "error_classified") {
		t.Error("missing message")
	}
	if !strings.Contains(out, "trace-xyz") {
		t.Error("missing trace_id")
	}
}

func TestRedactEndpoint(t *testing.T) {
	t.Parallel()

	tests := []struct {
		input string
		want  string
	}{
		{"https://mcp.dingtalk.com/api", "https://mcp.dingtalk.com/api"},
		{"https://mcp.dingtalk.com/api?token=abc", "https://mcp.dingtalk.com/api"},
		{"https://mcp.dingtalk.com/api#section", "https://mcp.dingtalk.com/api"},
		{"", ""},
	}

	for _, tt := range tests {
		t.Run(tt.input, func(t *testing.T) {
			t.Parallel()
			if got := redactEndpoint(tt.input); got != tt.want {
				t.Errorf("redactEndpoint(%q) = %q, want %q", tt.input, got, tt.want)
			}
		})
	}
}