apm_tracing.go 11 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235236237238239240241242243244245246247248249250251252253254255256257258259260261262263264265266267268269270271272273274275276277278279280281282283284285286287288289290291292293294295296297298299300301302303304305306307308309310311312313314315316317318319320321322323324325326327328329330331332333334335336337338339340341342343344345346347348349350351352353354355356357358359360361362
  1. package tracing
  2. import (
  3. "context"
  4. "fmt"
  5. "github.com/coroot/coroot-node-agent/ebpftracer"
  6. "github.com/coroot/coroot-node-agent/utils"
  7. "sync/atomic"
  8. "time"
  9. "strconv"
  10. "github.com/coroot/coroot-node-agent/ebpftracer/l7"
  11. "go.opentelemetry.io/otel/attribute"
  12. "go.opentelemetry.io/otel/codes"
  13. semconv "go.opentelemetry.io/otel/semconv/v1.18.0"
  14. "go.opentelemetry.io/otel/trace"
  15. "inet.af/netaddr"
  16. )
  17. /**
  18. * Trace
  19. */
  20. func (t *Trace) setContext(ctx context.Context) {
  21. t.lock.Lock()
  22. defer t.lock.Unlock()
  23. t.ctx = ctx
  24. }
  25. func (t *Trace) setSpan(span trace.Span) {
  26. t.lock.Lock()
  27. defer t.lock.Unlock()
  28. t.span = span
  29. }
  30. func (t *Trace) startReady() {
  31. t.lock.Lock()
  32. defer t.lock.Unlock()
  33. t.startEventReady = true
  34. }
  35. func (t *Trace) endReadyEvent(needCount uint32) {
  36. t.lock.Lock()
  37. defer t.lock.Unlock()
  38. t.endEventReady = true
  39. t.needEventCount = needCount
  40. }
  41. func (t *Trace) AllEventReady(traceID uint64) bool {
  42. //fmt.Printf("[AllEventReady (current/need)|start|end|traceid](%d/%d)%v|%v|%d\n", *t.currenEventCount, t.needEventCount, t.startEventReady, t.endEventReady, traceID)
  43. return t.startEventReady && t.endEventReady && *t.currenEventCount >= t.needEventCount
  44. }
  45. func (t *Trace) TraceStartEvent(method, path string, status l7.Status, addr netaddr.IPPort) {
  46. t.span.SetAttributes(semconv.HTTPURL(fmt.Sprintf("http://%s%s", addr.String(), path)),
  47. semconv.HTTPMethod(method),
  48. attribute.String("http.uri", path))
  49. if status > 399 {
  50. t.span.SetStatus(codes.Error, "")
  51. }
  52. t.destination = addr
  53. t.commonAttrs = []attribute.KeyValue{
  54. semconv.NetPeerName(addr.IP().String()),
  55. semconv.NetPeerPort(int(addr.Port())),
  56. }
  57. t.span.SetAttributes(t.commonAttrs...)
  58. t.startReady()
  59. }
  60. // set context span
  61. func (t *Trace) CreateRootSpan(traceId uint64) {
  62. traceIdStr := strconv.Itoa(int(traceId))
  63. ctx, span := tracer(t.containerId).Start(context.Background(), traceIdStr, trace.WithSpanKind(trace.SpanKindClient))
  64. t.setContext(ctx)
  65. t.setSpan(span)
  66. }
  67. func (t *Trace) TraceStart(method, path string, status l7.Status, duration time.Duration) {
  68. if t == nil || method == "" {
  69. return
  70. }
  71. t.createParentSpan("APPLICATION", duration, status >= 400,
  72. semconv.HTTPURL(fmt.Sprintf("http://%s%s", t.destination.String(), path)),
  73. semconv.HTTPMethod(method),
  74. //semconv.HTTPStatusCode(int(status)),
  75. attribute.String("http.uri", path),
  76. )
  77. }
  78. func (t *Trace) TraceEnd(r *l7.RequestData) {
  79. if t == nil {
  80. return
  81. }
  82. t.span.SetAttributes(
  83. semconv.HTTPStatusCode(int(r.Status)),
  84. attribute.String("server.trace_id_from", r.ParentSpanContext.TraceIdFrom),
  85. )
  86. CalledId, err := strconv.ParseInt(r.ParentSpanContext.CalledId, 10, 64)
  87. if err == nil && CalledId != 0 {
  88. t.span.SetAttributes(attribute.Int64("server.called_id", CalledId))
  89. }
  90. InstanceIdFrom, err := strconv.ParseInt(r.ParentSpanContext.InstanceIdFrom, 10, 64)
  91. if err == nil && InstanceIdFrom != 0 {
  92. t.span.SetAttributes(attribute.Int64("server.instance_id_from", InstanceIdFrom))
  93. }
  94. AppIdFrom, err := strconv.ParseInt(r.ParentSpanContext.AppIdFrom, 10, 64)
  95. if err == nil && AppIdFrom != 0 {
  96. t.span.SetAttributes(attribute.Int64("server.app_id_from", AppIdFrom))
  97. }
  98. if r.ParentSpanContext.SpanIdFrom != "0000000000000000" {
  99. t.span.SetAttributes(attribute.String("server.span_id_from", r.ParentSpanContext.SpanIdFrom))
  100. }
  101. t.span.End(trace.WithTimestamp(time.Now()))
  102. }
  103. // 新增结束事件
  104. func (t *Trace) TraceEndEvent(r *l7.RequestData) {
  105. if t == nil {
  106. return
  107. }
  108. var attr []attribute.KeyValue
  109. attr = append(attr,
  110. semconv.HTTPStatusCode(int(r.Status)),
  111. attribute.String("server.trace_id_from", r.ParentSpanContext.TraceIdFrom),
  112. )
  113. //t.span.SetAttributes(
  114. // semconv.HTTPStatusCode(int(r.Status)),
  115. // attribute.String("server.trace_id_from", r.ParentSpanContext.TraceIdFrom),
  116. //)
  117. calledId, err := strconv.ParseInt(r.ParentSpanContext.CalledId, 10, 64)
  118. if err == nil && calledId != 0 {
  119. attr = append(attr, attribute.Int64("server.called_id", calledId))
  120. //t.span.SetAttributes(attribute.Int64("server.called_id", CalledId))
  121. }
  122. instanceIdFrom, err := strconv.ParseInt(r.ParentSpanContext.InstanceIdFrom, 10, 64)
  123. if err == nil && instanceIdFrom != 0 {
  124. attr = append(attr, attribute.Int64("server.instance_id_from", instanceIdFrom))
  125. //t.span.SetAttributes(attribute.Int64("server.instance_id_from", InstanceIdFrom))
  126. }
  127. appIdFrom, err := strconv.ParseInt(r.ParentSpanContext.AppIdFrom, 10, 64)
  128. if err == nil && appIdFrom != 0 {
  129. attr = append(attr, attribute.Int64("server.app_id_from", appIdFrom))
  130. //t.span.SetAttributes(attribute.Int64("server.app_id_from", AppIdFrom))
  131. }
  132. if r.ParentSpanContext.SpanIdFrom != "0000000000000000" {
  133. attr = append(attr, attribute.String("server.span_id_from", r.ParentSpanContext.SpanIdFrom))
  134. //t.span.SetAttributes(attribute.String("server.span_id_from", r.ParentSpanContext.SpanIdFrom))
  135. }
  136. t.appendTimestamp(&attr, r.StartAt, r.EndAt, r.Duration.Nanoseconds())
  137. t.span.SetAttributes(attr...)
  138. t.endReadyEvent(r.EventCount)
  139. }
  140. func (t *Trace) appendTimestamp(attr *[]attribute.KeyValue, s, e uint64, d int64) {
  141. *attr = append(*attr,
  142. attribute.Int64("time.start_at", utils.KtimeToTimestamp(s)),
  143. attribute.Int64("time.end_at", utils.KtimeToTimestamp(e)),
  144. attribute.Int64("time.duration", d),
  145. )
  146. }
  147. func (t *Trace) createParentSpan(name string, duration time.Duration, error bool, attrs ...attribute.KeyValue) {
  148. end := time.Now()
  149. start := end.Add(-duration)
  150. ctx, span := tracer(t.containerId).Start(context.Background(), name, trace.WithTimestamp(start), trace.WithSpanKind(trace.SpanKindClient))
  151. span.SetAttributes(attrs...)
  152. span.SetAttributes(t.commonAttrs...)
  153. if error {
  154. span.SetStatus(codes.Error, "")
  155. }
  156. t.setContext(ctx)
  157. t.setSpan(span)
  158. }
  159. func (t *Trace) SendEvent() {
  160. t.span.End()
  161. }
  162. func (t *Trace) GetSpan() trace.Span {
  163. return t.span
  164. }
  165. func (t *Trace) createTraceEvent(name string, eventType int, l7Type int, attrs ...attribute.KeyValue) {
  166. t.span.AddEventApm(name, eventType, l7Type, trace.WithAttributes(attrs...))
  167. atomic.AddUint32(t.currenEventCount, 1)
  168. }
  169. func (t *Trace) createTraceSpan(name string, duration time.Duration, error bool, attrs ...attribute.KeyValue) {
  170. end := time.Now()
  171. start := end.Add(-duration)
  172. //fmt.Println("createTraceSpan:", t.ctx)
  173. _, span := tracer(t.containerId).Start(t.ctx, name, trace.WithTimestamp(start), trace.WithSpanKind(trace.SpanKindClient))
  174. span.SetAttributes(t.commonAttrs...)
  175. span.SetAttributes(attrs...)
  176. if error {
  177. span.SetStatus(codes.Error, "")
  178. }
  179. span.End(trace.WithTimestamp(end))
  180. }
  181. func (t *Trace) MysqlTraceQuery(query string, error bool, duration time.Duration, destination netaddr.IPPort) {
  182. if t == nil || query == "" {
  183. return
  184. }
  185. t.createTraceSpan(l7.ProtocolMysql.String(), duration, error,
  186. semconv.DBSystemMySQL,
  187. semconv.DBStatement(query),
  188. semconv.NetPeerName(destination.IP().String()),
  189. semconv.NetPeerPort(int(destination.Port())),
  190. )
  191. }
  192. func (t *Trace) MysqlTraceQueryEvent(query string, r *l7.RequestData, destination netaddr.IPPort) {
  193. if t == nil || query == "" {
  194. return
  195. }
  196. var attr []attribute.KeyValue
  197. attr = append(attr,
  198. semconv.DBSystemMySQL,
  199. semconv.DBStatement(query),
  200. semconv.NetPeerName(destination.IP().String()),
  201. semconv.NetPeerPort(int(destination.Port())),
  202. )
  203. t.appendTimestamp(&attr, r.StartAt, r.EndAt, r.Duration.Nanoseconds())
  204. t.createTraceEvent(l7.ProtocolHTTP.String(), int(ebpftracer.EventTypeL7Request), int(l7.ProtocolMysql), attr...)
  205. }
  206. func (t *Trace) RedisTraceQuery(cmd, args string, error bool, duration time.Duration) {
  207. if t == nil || cmd == "" {
  208. return
  209. }
  210. statement := cmd
  211. if args != "" {
  212. statement += " " + args
  213. }
  214. t.createTraceSpan(l7.ProtocolRedis.String(), duration, error,
  215. semconv.DBSystemRedis,
  216. semconv.DBOperation(cmd),
  217. semconv.DBStatement(statement),
  218. )
  219. }
  220. func (t *Trace) RedisTraceQueryEvent(cmd, args string, r *l7.RequestData) {
  221. if t == nil || cmd == "" {
  222. return
  223. }
  224. statement := cmd
  225. if args != "" {
  226. statement += " " + args
  227. }
  228. var attr []attribute.KeyValue
  229. attr = append(attr,
  230. semconv.DBSystemRedis,
  231. semconv.DBOperation(cmd),
  232. semconv.DBStatement(statement),
  233. )
  234. t.appendTimestamp(&attr, r.StartAt, r.EndAt, r.Duration.Nanoseconds())
  235. t.createTraceEvent(l7.ProtocolHTTP.String(), int(ebpftracer.EventTypeL7Request), int(l7.ProtocolRedis), attr...)
  236. }
  237. func (t *Trace) HttpTraceRequest(method, path, ip string, port uint16, r *l7.RequestData) {
  238. if t == nil || method == "" {
  239. return
  240. }
  241. assumedAppID, err := strconv.ParseInt(r.AssumedAppId, 10, 64)
  242. if err != nil {
  243. assumedAppID = 0
  244. }
  245. status := r.Status
  246. duration := r.Duration
  247. t.createTraceSpan(l7.ProtocolHTTP.String(), duration, status >= 400,
  248. semconv.HTTPURL(fmt.Sprintf("http://%s%s", t.destination.String(), path)),
  249. semconv.HTTPMethod(method),
  250. semconv.HTTPStatusCode(int(status)),
  251. attribute.String("http.uri", path),
  252. attribute.String("http.ip", ip),
  253. attribute.Int64("http.assumed_app_id", assumedAppID),
  254. attribute.String("http.span_id", r.SpanId),
  255. attribute.Int("http.port", int(port)),
  256. )
  257. }
  258. // 新增事件处理
  259. func (t *Trace) HttpTraceRequestEvent(method, path, ip string, port uint16, r *l7.RequestData) {
  260. if t == nil || method == "" {
  261. return
  262. }
  263. assumedAppID, err := strconv.ParseInt(r.AssumedAppId, 10, 64)
  264. if err != nil {
  265. assumedAppID = 0
  266. }
  267. status := r.Status
  268. var attr []attribute.KeyValue
  269. attr = append(attr,
  270. semconv.HTTPURL(fmt.Sprintf("http://%s%s", t.destination.String(), path)),
  271. semconv.HTTPMethod(method),
  272. semconv.HTTPStatusCode(int(status)),
  273. attribute.Bool("http.status_error", status > 399),
  274. attribute.String("http.uri", path),
  275. attribute.String("http.ip", ip),
  276. attribute.Int64("http.assumed_app_id", assumedAppID),
  277. attribute.String("http.span_id", r.SpanId),
  278. attribute.Int("http.port", int(port)),
  279. )
  280. t.appendTimestamp(&attr, r.StartAt, r.EndAt, r.Duration.Nanoseconds())
  281. t.createTraceEvent(l7.ProtocolHTTP.String(), int(ebpftracer.EventTypeL7Request), int(l7.ProtocolHTTP), attr...)
  282. }
  283. func (t *Trace) FuncTraceQuery(funcname string, duration time.Duration, start uint64, end uint64) {
  284. if t == nil || funcname == "" {
  285. return
  286. }
  287. t.createTraceSpanNoTime2(funcname, duration, false, start, end)
  288. }
  289. func (t *Trace) createTraceSpanNoTime(name string, duration time.Duration, error bool, start uint64, end uint64, attrs ...attribute.KeyValue) {
  290. // end := time.Now()
  291. // start := end.Add(-duration)
  292. startTime := time.Unix(0, int64(start))
  293. endTime := time.Unix(0, int64(end))
  294. //fmt.Println("createTraceSpan:", t.ctx)
  295. _, span := tracer(t.containerId).Start(t.ctx, name, trace.WithTimestamp(startTime), trace.WithSpanKind(trace.SpanKindClient))
  296. span.SetAttributes(t.commonAttrs...)
  297. span.SetAttributes(attrs...)
  298. if error {
  299. span.SetStatus(codes.Error, "")
  300. }
  301. span.End(trace.WithTimestamp(endTime))
  302. }
  303. func (t *Trace) createTraceSpanNoTime2(name string, duration time.Duration, error bool, start uint64, end uint64) {
  304. // end := time.Now()
  305. // start := end.Add(-duration)
  306. //startTime := time.Unix(0, int64(start))
  307. //endTime := time.Unix(0, int64(end))
  308. ////fmt.Println("createTraceSpan:", t.ctx)
  309. //_, span := tracer(t.containerId).Start(t.ctx, name, trace.WithTimestamp(startTime), trace.WithSpanKind(trace.SpanKindClient))
  310. //span.SetAttributes(t.commonAttrs...)
  311. //span.SetAttributes(attrs...)
  312. //if error {
  313. // span.SetStatus(codes.Error, "")
  314. //}
  315. //span.End(trace.WithTimestamp(endTime))
  316. //attrs = append([]attribute.KeyValue{
  317. // attribute.Int64("startAt", int64(start)),
  318. // attribute.Int64("endAt", int64(end)),
  319. //})
  320. var attr []attribute.KeyValue
  321. t.appendTimestamp(&attr, start, end, int64(end-start))
  322. t.createTraceEvent(name, int(ebpftracer.EventTypeFunEnt), 0, attr...)
  323. }