modifying 'great'

OK--I figured out how to use the deterministic SBCL profiler (SBCL
1.0.13 / Windows XP) I traced the same functions as in your
report. What's the story with new-file-search1?  Notice that the
number of calls to 'great' basically match my other experiment--the
difference is the CVS test suite vs the 5.14.0 tests, I think.

measuring PROFILE overhead..done
  seconds  |     consed     |    calls    |  sec/call  |  name
------------------------------------------------------------------
    36.387 |    447,354,856 |     134,280 |   0.000271 | NEW-FILE-SEARCH1
     8.288 |    787,730,736 |     755,948 |   0.000011 | EXPLODEN
     4.054 |    956,902,680 |     451,970 |   0.000009 | PRINT-INVERT-CASE
     0.792 |    157,708,904 |       7,321 |   0.000108 | ZGCD
     0.559 |    664,685,608 |   3,294,192 |  0.0000002 | EQTEST
     0.000 |  1,258,182,352 |   2,842,954 |   0.000000 | TMS
     0.000 |     42,852,704 |         168 |   0.000000 | LHOSPITAL-CATCH
     0.000 |  1,369,865,160 |   1,396,693 |   0.000000 | TIMESIN
     0.000 |        589,656 |  10,231,194 |   0.000000 | ZEROP1
     0.000 |  1,730,269,264 |     759,237 |   0.000000 | SIMPEXPT
     0.000 |  1,948,646,552 |  28,028,040 |   0.000000 | ALIKE1
     0.000 |  2,232,979,312 |   1,176,194 |   0.000000 | ASSOL
     0.000 |     76,045,976 |         262 |   0.000000 | SIMPLIMPLUS
     0.000 |      1,621,632 |  33,784,015 |   0.000000 | MEMQ
     0.000 |    241,071,656 |       2,181 |   0.000000 | $LIMIT
     0.000 |        226,152 |   5,495,553 |   0.000000 | PZEROP
     0.000 |  1,872,090,248 |   3,397,963 |   0.000000 | GREAT
     0.000 |  6,457,019,744 |   5,821,865 |   0.000000 | SIMPLIFYA
     0.000 |    257,959,312 |     593,160 |   0.000000 | ORDLIST
     0.000 |    293,129,896 |   1,009,327 |   0.000000 | PLS
     0.000 |    602,004,464 |     294,781 |   0.000000 | PLUSIN
     0.000 |    387,825,464 |   2,154,875 |   0.000000 | VISIBLEP
     0.000 |  1,340,288,760 |   4,591,863 |   0.000000 | ALIKE
     0.000 |     97,492,576 |      70,488 |   0.000000 | $BFLOAT
     0.000 |      2,588,144 |   4,089,724 |   0.000000 | ONEP1
     0.000 |        102,328 |   2,183,960 |   0.000000 | CNTP
     0.000 |    504,860,184 |     458,801 |   0.000000 | SIMPLUS
     0.000 |        855,760 |  12,831,186 |   0.000000 | MNUMP
     0.000 |    465,942,856 |   2,255,620 |   0.000000 | MEMALIKE
------------------------------------------------------------------
    50.081 | 24,198,892,936 | 128,113,815 |            | Total

estimated total profiling overhead: 300.30 seconds

Barton


>
>       Consed |       Calls |     Secs | Sec/Call |  Bytes/C. | Name:
>-----------------------------------------------------------------------
>  156,483,792 |   2,470,902 |   85.318 |  0.00003 |        63 | TMS
>  142,466,784 |          69 |   76.630 |  1.11058 | 2,064,736 |
>LHOSPITAL-CATCH
>  129,873,664 |   1,151,059 |   58.418 |  0.00005 |       113 | TIMESIN
>   92,101,096 |     978,745 |   55.243 |  0.00006 |        94 | SIMPTIMES
>   76,579,384 |  10,362,257 |   54.715 |  0.00001 |         7 | ZEROP1
>   98,016,336 |     507,306 |   52.525 |  0.00010 |       193 | SIMPEXPT
>   53,393,504 |  23,049,831 |   51.620 |  0.00000 |         2 | ALIKE1
>  299,087,480 |         569 |   45.489 |  0.07995 |   525,637 |
>NEW-FILE-SEARCH1
>   93,168,208 |   1,181,579 |   44.347 |  0.00004 |        79 | ASSOL
>   84,078,400 |         142 |   42.710 |  0.30077 |   592,101 |
>SIMPLIMPLUS
>            0 |  34,166,994 |   38.046 |  0.00000 |         0 | MEMQ
>   66,143,808 |       1,804 |   36.946 |  0.02048 |    36,665 | $LIMIT
>   63,818,632 |       6,425 |   35.987 |  0.00560 |     9,933 | ZGCD
>   44,228,592 |   5,521,780 |   29.106 |  0.00001 |         8 | PZEROP
>   45,798,640 |   1,661,359 |   27.127 |  0.00002 |        28 | GREAT
>   39,527,400 |   1,718,403 |   26.873 |  0.00002 |        23 | SIMPLIFYA
>  307,411,360 |     756,390 |   25.777 |  0.00003 |       406 | EXPLODEN
>   40,555,888 |   3,332,631 |   22.535 |  0.00001 |        12 | EQTEST
>   39,706,560 |     558,379 |   22.333 |  0.00004 |        71 | ORDLIST
>   50,677,048 |   1,030,046 |   21.170 |  0.00002 |        49 | PLS
>   40,170,840 |     296,955 |   20.886 |  0.00007 |       135 | PLUSIN
>   36,612,512 |   2,288,267 |   20.533 |  0.00001 |        16 | VISIBLEP
>   29,516,472 |   2,688,265 |   20.303 |  0.00001 |        11 | ALIKE
>            0 |  15,039,570 |   19.081 |  0.00000 |         0 | $BFLOATP
>   26,620,448 |   4,121,335 |   17.897 |  0.00000 |         6 | ONEP1
>   27,724,088 |   2,318,119 |   15.864 |  0.00001 |        12 | CNTP
>   24,853,056 |     422,383 |   15.605 |  0.00004 |        59 | SIMPLUS
>            0 |  12,988,560 |   15.183 |  0.00000 |         0 | MNUMP
>  286,571,832 |     452,237 |   14.286 |  0.00003 |       634 |
>PRINT-INVERT-CASE
>   22,378,544 |   2,277,281 |   13.785 |  0.00001 |        10 | MEMALIKE
>...
>-------------------------------------------------------------------
>5,209,961,048 | 287,304,055 | 2101.466 |          |           | Total
>
>The times are exclusive, I think.  That is, the time reported is the
>time spent in the function, not including time spent in functions
>called from that function.
>
>Not sure I trust these results though.  The test took over 2000 sec,
>but normally only takes 200 or so.  I guess profiling overhead is
>pretty big.
>
>I think SBCL could give better results here with its statisical
>profiler....
>
>Ray