package middlewares

import (
	"net/http"
	"net/http/httptest"
	"testing"

	"github.com/gin-gonic/gin"
	"github.com/go-logr/logr"
	"github.com/go-logr/zapr"
	"go.uber.org/zap"
	"go.uber.org/zap/zapcore"
	"go.uber.org/zap/zaptest/observer"
)

func newObservedMiddlewareLogger() (logr.Logger, *observer.ObservedLogs) {
	core, logs := observer.New(zapcore.Level(-10))
	return zapr.NewLogger(zap.New(core)), logs
}

func TestLogMetricMiddlewareLogsRequestLifecycleAtDebugLevel(t *testing.T) {
	gin.SetMode(gin.TestMode)

	log, logs := newObservedMiddlewareLogger()
	router := gin.New()
	router.Use((&LogMetricMiddlewareBuilder{
		Request: RequestLoggerOptions{
			Logger: log,
			FilterFunc: func(c *gin.Context) bool {
				return false
			},
		},
	}).Build())
	router.GET("/ok", func(c *gin.Context) {
		c.JSON(http.StatusOK, gin.H{"status": "ok"})
	})

	rec := httptest.NewRecorder()
	req := httptest.NewRequest(http.MethodGet, "/ok?debug=true", nil)
	router.ServeHTTP(rec, req)

	if rec.Code != http.StatusOK {
		t.Fatalf("expected status 200, got %d", rec.Code)
	}

	entries := logs.AllUntimed()
	if len(entries) != 2 {
		t.Fatalf("expected request start and completion logs, got %d entries: %#v", len(entries), entries)
	}
	if entries[0].Message != "request started" {
		t.Fatalf("expected first log to be request started, got %q", entries[0].Message)
	}
	if entries[1].Message != "request completed" {
		t.Fatalf("expected second log to be request completed, got %q", entries[1].Message)
	}
	if entries[0].Level != -4 || entries[1].Level != -4 {
		t.Fatalf("expected debug verbosity 4 logs, got levels %d and %d", entries[0].Level, entries[1].Level)
	}

	startCtx := entries[0].ContextMap()
	if got := startCtx["method"]; got != http.MethodGet {
		t.Fatalf("expected method GET in start log, got %v", got)
	}
	if got := startCtx["path"]; got != "/ok" {
		t.Fatalf("expected path /ok in start log, got %v", got)
	}

	doneCtx := entries[1].ContextMap()
	if got := doneCtx["status_code"]; got != int64(http.StatusOK) {
		t.Fatalf("expected status 200 in completion log, got %v", got)
	}
	if got := doneCtx["matched_path"]; got != "/ok" {
		t.Fatalf("expected matched path /ok in completion log, got %v", got)
	}
	if got := doneCtx["query"]; got != "debug=true" {
		t.Fatalf("expected query debug=true in completion log, got %v", got)
	}
}