What does MiniProfiler information mean?

Hi All

I love Miniprofiler. It has helped me tremendously especially for finding things like n+1 queries. However, as the low hanging fruit becomes harder to find the miniprofiler output becomes harder to understand.

Unfortunately, I can’t upload a screen shot so I’ll just past the output text here. If I try to follow the data using the timestamps as a guide I’m lost immediately because sometimes the output is sometimes adds more confusion rather than illuminate the problem.

I’ve reproduced a sample of the mini profiler output from my production rails app. How do I investigate this gap 3667.80ms? It’s not clear what the source is since it looks like the step before only took 123ms in total.

Thanks


Gap: 29.90 ms


Executing action: create — 29.90 ms
Executing action: create
T+122.9 ms
Reader
0.1 ms
[STACKTRACE 1]
[SQL SELECT STATEMENT ]


GAP 3667.80 ms – Executing action: create — 2931.42 ms


Executing action: create
T+3790.8 ms
Reader
1.2 ms

[STACKTRACE2]
BEGIN


Gap 29.90 ms – Executing action: create — 29.90 ms


Executing action: create
T+3821.9 ms
Reader
0.1 ms

[STACKTRACE 3]

[SQL INSERT STATEMENT]


GAP: 738.00 ms Net::HTTP PUT /tiles/7697/8227850cd103ca78200fb21415e6f4a8f0636f4e__screen_shot_2015-07-15_at_2-09-11_pm.png — 596.70 ms


Executing action: create
T+4560.0 ms
Reader
5.0 ms
[STACKTRACE 3]
COMMIT