cancel
Showing results for 
Show  only  | Search instead for 
Did you mean: 
Not a customer? Start a free trial

Click the Start a free trial link to start a 15-day SaaS trial of our product and join our community as a trial user. If you are an existing customer do not start a free trial.

AppDynamics customers and established members should click the sign in button to authenticate.

Java (Java Agent, Installation, JVM, and Controller Installation)

Method time in partial callgraphs in slow responses drill down

Unmesh.Joshi
Creator

Method time in partial callgraphs in slow responses drill down

Hi,

I am trying to interpret the time values shown in the call graph in the slow responses drill-down view

 

Call graph from TransactionFunction
On tier: MyTier
On node: server2:8085
Start time: 04/17/20 5:39:03 PM
Snapshot GUID: f0592eab-d62b-4dfd-b87e-91a10083c9b1

java.lang.Thread:run:748 (method time = 0 ms, total time = 1090 ms)
com.demobank.gemfire.functions.TransactionsFunction:execute:33 (method time = 0 ms, total time = 1090 ms)
com.demobank.gemfire.functions.TransactionsFunction:getPage:56 (method time = 0 ms, total time = 1090 ms)
com.demobank.gemfire.functions.RealtimeStockClient:getStockPrices:22 (method time = 0 ms, total time = 1090 ms)
okhttp3.ResponseBody:string:187 (method time = 0 ms, total time = 1078 ms)
okio.RealBufferedSource:readString:95 (method time = 0 ms, total time = 1078 ms)
okio.Buffer:writeAll:1655 (method time = 0 ms, total time = 1078 ms)
okhttp3.internal.connection.Exchange$ResponseBodySource:read:276 (method time = 0 ms, total time = 1078 ms)
okhttp3.internal.http1.Http1ExchangeCodec$ChunkedSource:read:430 (method time = 0 ms, total time = 1078 ms)
okhttp3.internal.http1.Http1ExchangeCodec$AbstractSource:read:349 (method time = 0 ms, total time = 1078 ms)
okio.RealBufferedSource:read:188 (method time = 0 ms, total time = 1078 ms)
okio.AsyncTimeout$source$1:read:129 (method time = 0 ms, total time = 1078 ms)
okio.InputStreamSource:read:90 (method time = 1078 ms, total time = 1078 ms)
com.demobank.gemfire.functions.JsonSerDes:deserialize:34 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.databind.ObjectMapper:readValue:3091 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.databind.ObjectMapper:_readMapAndClose:4013 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.databind.deser.std.MapDeserializer:deserialize:29 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.databind.deser.std.MapDeserializer:deserialize:364 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.databind.deser.std.MapDeserializer:_readAndBindStringKeyMap:527 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.databind.deser.std.UntypedObjectDeserializer$Vanilla:deserialize:654 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.databind.deser.std.UntypedObjectDeserializer$Vanilla:mapObject:896 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.json.UTF8StreamJsonParser:nextFieldName:999 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.json.UTF8StreamJsonParser:_parseName:1672 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.json.UTF8StreamJsonParser:parseMediumName:1737 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.json.UTF8StreamJsonParser:parseMediumName2:1780 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.json.UTF8StreamJsonParser:parseLongName:1816 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.json.UTF8StreamJsonParser:findName:2209 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.json.UTF8StreamJsonParser:addName:2325 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.sym.ByteQuadsCanonicalizer:addName:809 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.sym.ByteQuadsCanonicalizer:_verifySharing:880 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.sym.ByteQuadsCanonicalizer:rehash:1132 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.sym.ByteQuadsCanonicalizer:addName:811 (method time = 0 ms, total time = 12 ms)
com.fasterxml.jackson.core.util.InternCache:intern:60 (method time = 12 ms, total time = 12 ms)
com.demobank.gemfire.functions.TransactionsFunction:execute:36 (method time = 0 ms, total time = 0 ms)]

 

 

 

and I have another one, which shows Thread.run method time as 2062 ms

Call graph from TransactionFunction
On tier: MyTier
On node: server2:8085
Start time: 04/17/20 5:38:25 PM
Snapshot GUID: 56969fb0-986e-40c5-8751-703ffc552ec8

java.lang.Thread:run:748 (method time = 2062 ms, total time = 4378 ms)
com.demobank.gemfire.functions.TransactionsFunction:execute:33 (method time = 0 ms, total time = 0 ms)
com.demobank.gemfire.functions.TransactionsFunction:execute:33 (method time = 0 ms, total time = 849 ms)
com.demobank.gemfire.functions.TransactionsFunction:getPage:56 (method time = 0 ms, total time = 849 ms)
com.demobank.gemfire.functions.RealtimeStockClient:getStockPrices:21 (method time = 0 ms, total time = 849 ms)
okhttp3.internal.connection.RealCall:execute:150 (method time = 849 ms, total time = 849 ms)
HTTP(2901ms): https://www.alphavantage.co:443/query?function=TIME_SERIES_INTRADAY&symbol=IBM&interval=5min&outputs...
com.demobank.gemfire.functions.TransactionsFunction:execute:33 (method time = 0 ms, total time = 1467 ms)
com.demobank.gemfire.functions.TransactionsFunction:getPage:56 (method time = 2 ms, total time = 1467 ms)
com.demobank.gemfire.functions.RealtimeStockClient:getStockPrices:22 (method time = 0 ms, total time = 1465 ms)
okhttp3.ResponseBody:string:187 (method time = 0 ms, total time = 1465 ms)
okhttp3.internal.Util:readBomAsCharset:256 (method time = 0 ms, total time = 406 ms)
okio.RealBufferedSource:select:231 (method time = 0 ms, total time = 406 ms)
okhttp3.internal.connection.Exchange$ResponseBodySource:read:276 (method time = 0 ms, total time = 406 ms)
okhttp3.internal.http1.Http1ExchangeCodec$ChunkedSource:read:426 (method time = 0 ms, total time = 406 ms)
okhttp3.internal.http1.Http1ExchangeCodec$ChunkedSource:readChunkSize:447 (method time = 0 ms, total time = 406 ms)
okio.RealBufferedSource:readHexadecimalUnsignedLong:400 (method time = 0 ms, total time = 406 ms)
okio.RealBufferedSource:require:201 (method time = 0 ms, total time = 406 ms)
okio.RealBufferedSource:request:207 (method time = 0 ms, total time = 406 ms)
okio.AsyncTimeout$source$1:read:129 (method time = 0 ms, total time = 406 ms)
okio.InputStreamSource:read:90 (method time = 406 ms, total time = 406 ms)
okio.RealBufferedSource:readString:95 (method time = 0 ms, total time = 1059 ms)
okio.Buffer:writeAll:1655 (method time = 0 ms, total time = 1059 ms)
okhttp3.internal.connection.Exchange$ResponseBodySource:read:276 (method time = 0 ms, total time = 1059 ms)
okhttp3.internal.http1.Http1ExchangeCodec$ChunkedSource:read:430 (method time = 0 ms, total time = 1059 ms)
okhttp3.internal.http1.Http1ExchangeCodec$AbstractSource:read:349 (method time = 0 ms, total time = 1059 ms)
okio.RealBufferedSource:read:188 (method time = 0 ms, total time = 1059 ms)
okio.AsyncTimeout$source$1:read:129 (method time = 0 ms, total time = 1059 ms)
okio.InputStreamSource:read:90 (method time = 1059 ms, total time = 1059 ms)
com.demobank.gemfire.functions.TransactionsFunction:execute:36 (method time = 0 ms, total time = 0 ms)

 

How to interpret the Thread.run method time in these two graphs?

 

Thanks,

Unmesh

Tags (2)
By replying you agree to the Terms and Conditions of the AppDynamics Community.
Method time in partial callgraphs in slow responses drill down
0 REPLIES 0