steel2013 opened a new issue #1064: 发送http响应时间耗时过长
URL: https://github.com/apache/incubator-brpc/issues/1064
 
 
   statusvarsconnectionsflagsrpczcpuheapgrowthcontentionmore?
   2020/01/13-17:21:50.756843 Received request(368) from 127.0.0.1:33223 http 
log_id=0 trace=dd6968a2cb63197a span=3fee23e0a136197a
   17:21:50.756940    .    97 Processing the request in a new bthread
   17:21:50.756950    .    10 Enter HttpService.EntryDoc2_Get
   17:21:50.756969    .    19 [ncEACHttpServerUtil.cpp:54] ip: 172.16.251.4
   17:21:50.757498    .     6 [ncEACEntryDoc2Handler.cpp:102] this: 0x10df630, 
cntl: 0x7fea8c216db0, userId: b3c51f50-394f-11e7-b7c9-1866daf2fda0 begin
   17:21:50.757513    .    15 [ncEACHttpServerUtil.cpp:54] ip: 172.16.251.4
   17:21:50.757517    .     4 [ncACSDocManager.cpp:1549] [BEGIN]this: 0x10dfa10
   17:21:50.757522    .     5 [ncACSPermManager.cpp:673] this: 0x10dfaf0, 
userId: b3c51f50-394f-11e7-b7c9-1866daf2fda0, gnsPath: gns:// begin
   17:21:50.757529    .     7 [ncACSShareMgnt.cpp:159] [BEGIN]this: 0x10d5450
   17:21:50.757535    .     6 [ncACSShareMgnt.cpp:110] [BEGIN]this: 0x10d5450
   17:21:50.758062    .   527 [ncACSShareMgnt.cpp:129] [END]this: 0x10d5450
   17:21:50.759630    .  1568 [ncACSShareMgnt.cpp:191] [END]this: 0x10d5450
   17:21:50.759647    .    17 [ncACSShareMgnt.cpp:429] [BEGIN]this: 0x10d5450
   17:21:50.759983    .   336 [ncACSShareMgnt.cpp:446] [END]this: 0x10d5450
   17:21:50.759991    .     8 [ncDBPermManager.cpp:1041] docId: -1945481168, 
accessToken size: 5 begin
   17:21:50.773208    . 13217 [ncDBPermManager.cpp:1094] docId: gns://, 
accessToken size: 5 end, ret perms size: 396
   17:21:50.773468    .   260 [ncDBOwnerManager.cpp:340] [BEGIN]this: 
0x10b9540, userId: b3c51f50-394f-11e7-b7c9-1866daf2fda0
   17:21:50.774407    .   939 [ncDBOwnerManager.cpp:362] [END]this: 0x10b9540, 
userId: b3c51f50-394f-11e7-b7c9-1866daf2fda0, ret subObjs size: 1
   17:21:50.774452    .    45 [ncACSConfManager.cpp:380] this: 0x10e10e0 begin
   17:21:50.774456    .     4 [ncACSConfManager.cpp:385] this: 0x10e10e0 end
   17:21:50.774460    .     4 [ncACSShareMgnt.cpp:3354] this: 0x10d5450
   17:21:50.775530    .  1070 [ncDBDocManager.cpp:1123] this: 0x10bac10, types 
size: 0 begin
   17:21:50.777138    .  1608 [ncDBDocManager.cpp:1212] this: 0x10bac10, types 
size: 0 end, ret infos size: 26
   17:21:50.777169    .    31 [ncACSPermManager.cpp:884] this: 0x10dfaf0, 
userId: b3c51f50-394f-11e7-b7c9-1866daf2fda0, size: 26 begin
   17:21:50.777174    .     5 [ncACSShareMgnt.cpp:2733] [BEGIN]this: 0x10d5450
   17:21:50.777570    .   396 [ncACSShareMgnt.cpp:2749] [END]this: 0x10d5450
   17:21:50.777633    .    63 [ncACSProcessorUtil.cpp:345] [BEGIN]this: 
0x10de420
   17:21:50.780448    .  1271 [ncACSShareMgnt.cpp:886] [BEGIN]this: 0x10d5450
   17:21:50.781456    .  1008 [ncACSShareMgnt.cpp:916] [END]this: 0x10d5450
   17:21:50.782712    .    22 [ncACSProcessorUtil.cpp:475] [END]this: 0x10de420
   17:21:50.782884    .     2 [ncACSDocManager.cpp:1592] [END]this: 0x10dfa10
   17:21:50.783507    .   623 [ncEACEntryDoc2Handler.cpp:158] this: 0x10df630, 
cntl: 0x7fea8c216db0, userId: b3c51f50-394f-11e7-b7c9-1866daf2fda0 end
   17:21:50.783593    .    86 Leave HttpService.EntryDoc2_Get
   17:21:55.225824   4.442231 Responded(10961)
   
   
   
服务偶现响应慢,打开trace,最后两行显示耗时4s多,倒数第三行已是请求handler函数的最后一行,那么剩下的耗时是否消耗在brpc内部了,很疑惑,望解答!

----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
 
For queries about this service, please contact Infrastructure at:
[email protected]


With regards,
Apache Git Services

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to