Macro

Summary

Produces useful timing information, including information on garbage collection activity.

Package

hcl

Signature

extended-time &body body => timing-info

Arguments

body

The forms to be timed.

Values

timing-info

Timing information on the forms contained in body .

Description

The three columns show, respectively, total time, user time, and system time. "Main promote" indicates promotions from generation 0. "Internal promote" indicates when an attempt to promote from one generation to the next causes promotion of the higher generation, to make room for the objects from the lower generation. "fixup" is a part of the compaction and promotion process.

Example

USER 22 > (hcl:extended-time (hcl:clean-generation-0))

user time    =      1.320 

system time  =      0.100 

Elapsed time =  0:00:01 

Allocation = 144 

0 Page faults

total gc activity             = 0.960000 / 0.900000 /   0.060000 

main promote (0 calls)        = 0.000000 / 0.000000 /   0.000000 

mark and sweep (200 calls)    = 0.960000 / 0.900000 /   0.060000 

internal promote (  100 calls = 0.000000 / 0.000000 /   0.000000 

promote (    0 calls)         = 0.000000 / 0.000000 /   0.000000 

fixup   (  100 calls)         = 0.140000 / 0.120000 /   0.020000 

compact (    0 calls)         = 0.000000 / 0.000000 /   0.000000 

NIL

USER 23 > 

See also

time