hook_test.go 4.8 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173
  1. package redis
  2. import (
  3. "context"
  4. "log"
  5. "strings"
  6. "testing"
  7. "time"
  8. red "github.com/go-redis/redis/v8"
  9. "github.com/stretchr/testify/assert"
  10. "github.com/zeromicro/go-zero/core/logx"
  11. ztrace "github.com/zeromicro/go-zero/core/trace"
  12. tracesdk "go.opentelemetry.io/otel/trace"
  13. )
  14. func TestHookProcessCase1(t *testing.T) {
  15. ztrace.StartAgent(ztrace.Config{
  16. Name: "go-zero-test",
  17. Endpoint: "http://localhost:14268/api/traces",
  18. Batcher: "jaeger",
  19. Sampler: 1.0,
  20. })
  21. writer := log.Writer()
  22. var buf strings.Builder
  23. log.SetOutput(&buf)
  24. defer log.SetOutput(writer)
  25. ctx, err := durationHook.BeforeProcess(context.Background(), red.NewCmd(context.Background()))
  26. if err != nil {
  27. t.Fatal(err)
  28. }
  29. assert.Nil(t, durationHook.AfterProcess(ctx, red.NewCmd(context.Background())))
  30. assert.False(t, strings.Contains(buf.String(), "slow"))
  31. assert.Equal(t, "redis", tracesdk.SpanFromContext(ctx).(interface{ Name() string }).Name())
  32. }
  33. func TestHookProcessCase2(t *testing.T) {
  34. ztrace.StartAgent(ztrace.Config{
  35. Name: "go-zero-test",
  36. Endpoint: "http://localhost:14268/api/traces",
  37. Batcher: "jaeger",
  38. Sampler: 1.0,
  39. })
  40. w, restore := injectLog()
  41. defer restore()
  42. ctx, err := durationHook.BeforeProcess(context.Background(), red.NewCmd(context.Background()))
  43. if err != nil {
  44. t.Fatal(err)
  45. }
  46. assert.Equal(t, "redis", tracesdk.SpanFromContext(ctx).(interface{ Name() string }).Name())
  47. time.Sleep(slowThreshold.Load() + time.Millisecond)
  48. assert.Nil(t, durationHook.AfterProcess(ctx, red.NewCmd(context.Background(), "foo", "bar")))
  49. assert.True(t, strings.Contains(w.String(), "slow"))
  50. assert.True(t, strings.Contains(w.String(), "trace"))
  51. assert.True(t, strings.Contains(w.String(), "span"))
  52. }
  53. func TestHookProcessCase3(t *testing.T) {
  54. writer := log.Writer()
  55. var buf strings.Builder
  56. log.SetOutput(&buf)
  57. defer log.SetOutput(writer)
  58. assert.Nil(t, durationHook.AfterProcess(context.Background(), red.NewCmd(context.Background())))
  59. assert.True(t, buf.Len() == 0)
  60. }
  61. func TestHookProcessCase4(t *testing.T) {
  62. writer := log.Writer()
  63. var buf strings.Builder
  64. log.SetOutput(&buf)
  65. defer log.SetOutput(writer)
  66. ctx := context.WithValue(context.Background(), startTimeKey, "foo")
  67. assert.Nil(t, durationHook.AfterProcess(ctx, red.NewCmd(context.Background())))
  68. assert.True(t, buf.Len() == 0)
  69. }
  70. func TestHookProcessPipelineCase1(t *testing.T) {
  71. writer := log.Writer()
  72. var buf strings.Builder
  73. log.SetOutput(&buf)
  74. defer log.SetOutput(writer)
  75. ctx, err := durationHook.BeforeProcessPipeline(context.Background(), []red.Cmder{red.NewCmd(context.Background())})
  76. if err != nil {
  77. t.Fatal(err)
  78. }
  79. assert.Equal(t, "redis", tracesdk.SpanFromContext(ctx).(interface{ Name() string }).Name())
  80. assert.Nil(t, durationHook.AfterProcessPipeline(ctx, []red.Cmder{
  81. red.NewCmd(context.Background()),
  82. }))
  83. assert.False(t, strings.Contains(buf.String(), "slow"))
  84. }
  85. func TestHookProcessPipelineCase2(t *testing.T) {
  86. ztrace.StartAgent(ztrace.Config{
  87. Name: "go-zero-test",
  88. Endpoint: "http://localhost:14268/api/traces",
  89. Batcher: "jaeger",
  90. Sampler: 1.0,
  91. })
  92. w, restore := injectLog()
  93. defer restore()
  94. ctx, err := durationHook.BeforeProcessPipeline(context.Background(), []red.Cmder{red.NewCmd(context.Background())})
  95. if err != nil {
  96. t.Fatal(err)
  97. }
  98. assert.Equal(t, "redis", tracesdk.SpanFromContext(ctx).(interface{ Name() string }).Name())
  99. time.Sleep(slowThreshold.Load() + time.Millisecond)
  100. assert.Nil(t, durationHook.AfterProcessPipeline(ctx, []red.Cmder{
  101. red.NewCmd(context.Background(), "foo", "bar"),
  102. }))
  103. assert.True(t, strings.Contains(w.String(), "slow"))
  104. assert.True(t, strings.Contains(w.String(), "trace"))
  105. assert.True(t, strings.Contains(w.String(), "span"))
  106. }
  107. func TestHookProcessPipelineCase3(t *testing.T) {
  108. w, restore := injectLog()
  109. defer restore()
  110. assert.Nil(t, durationHook.AfterProcessPipeline(context.Background(), []red.Cmder{
  111. red.NewCmd(context.Background()),
  112. }))
  113. assert.True(t, len(w.String()) == 0)
  114. }
  115. func TestHookProcessPipelineCase4(t *testing.T) {
  116. w, restore := injectLog()
  117. defer restore()
  118. ctx := context.WithValue(context.Background(), startTimeKey, "foo")
  119. assert.Nil(t, durationHook.AfterProcessPipeline(ctx, []red.Cmder{
  120. red.NewCmd(context.Background()),
  121. }))
  122. assert.True(t, len(w.String()) == 0)
  123. }
  124. func TestHookProcessPipelineCase5(t *testing.T) {
  125. writer := log.Writer()
  126. var buf strings.Builder
  127. log.SetOutput(&buf)
  128. defer log.SetOutput(writer)
  129. ctx := context.WithValue(context.Background(), startTimeKey, "foo")
  130. assert.Nil(t, durationHook.AfterProcessPipeline(ctx, []red.Cmder{red.NewCmd(context.Background())}))
  131. assert.True(t, buf.Len() == 0)
  132. }
  133. func injectLog() (r *strings.Builder, restore func()) {
  134. var buf strings.Builder
  135. w := logx.NewWriter(&buf)
  136. o := logx.Reset()
  137. logx.SetWriter(w)
  138. return &buf, func() {
  139. logx.Reset()
  140. logx.SetWriter(o)
  141. }
  142. }