spelunker icon indicating copy to clipboard operation
spelunker copied to clipboard

Debug timings are potentially confusing

Open timkurvers opened this issue 6 years ago • 1 comments

Spelunker uses debug for logging debug messages during operation.

One of its features, millisecond diffing, is potentially confusing:

When actively developing an application it can be useful to see when the time spent between one debug() call and the next. Suppose for example you invoke debug() before requesting a resource, and after as well, the "+NNNms" will show you how much time was spent between calls.

Given that Spelunker uses separate namespaces for timed operations – such as caching, DBC and database queries – these diffs may be interpret as query timers, which couldn't be further from the truth depending on the order of operations.

screen shot 2018-08-13 at 21 43 16

timkurvers avatar Aug 13 '18 19:08 timkurvers