Profiling results ----------------- Total cpu time observed: 21330ms (out of 21748ms) Number of samples taken: 67 (once every 318ms) ========================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================= ??? [3] 100.0% [1] 21330(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [2] 100.0% ------------------------------------------------------------------------- profile-thunk16 [1] 100.0% [2] 21330(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [3] 100.0% ------------------------------------------------------------------------- run [2] 50.0% [3] 21330(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% prepare-points-intervals [8] 44.2% errors [24] 2.2% run-improve40 [4] 1.4% eval-errors [5] 0.8% oracle-error [6] 0.8% baseline-error [7] 0.7% ------------------------------------------------------------------------- ??? [3] 100.0% [4] 592(2.8%) 0(0.0%) run-improve40 ...lify-tweak/src/mainloop.rkt:340:0 finalize-iter! [12] 50.7% prepare-points-intervals [8] 49.3% ------------------------------------------------------------------------- ??? [3] 100.0% [5] 334(1.6%) 0(0.0%) eval-errors ...simplify-tweak/src/points.rkt:203:0 for-loop [9] 100.0% ------------------------------------------------------------------------- ??? [3] 100.0% [6] 322(1.5%) 0(0.0%) oracle-error ...implify-tweak/src/points.rkt:212:0 for-loop [10] 100.0% ------------------------------------------------------------------------- ??? [3] 100.0% [7] 304(1.4%) 0(0.0%) baseline-error ...plify-tweak/src/points.rkt:216:0 argmin [11] 100.0% ------------------------------------------------------------------------- run-improve40 [4] 1.5% ??? [3] 98.5% [8] 19144(89.8%) 298(1.4%) prepare-points-intervals ...k/src/points.rkt:133:0 loop [13] 98.4% ------------------------------------------------------------------------- eval-errors [5] 100.0% [9] 334(1.6%) 0(0.0%) for-loop ...ie/simplify-tweak/src/points.rkt:205:2 ??? [31] 100.0% ------------------------------------------------------------------------- oracle-error [6] 100.0% [10] 322(1.5%) 0(0.0%) for-loop ...ie/simplify-tweak/src/points.rkt:213:2 map [14] 100.0% ------------------------------------------------------------------------- baseline-error [7] 100.0% [11] 304(1.4%) 0(0.0%) argmin ...acket-7.0/collects/racket/list.rkt:765:0 ??? [15] 100.0% ------------------------------------------------------------------------- run-improve40 [4] 100.0% [12] 300(1.4%) 0(0.0%) finalize-iter! ...ify-tweak/src/mainloop.rkt:272:0 ??? [16] 100.0% ------------------------------------------------------------------------- prepare-points-intervals [8] 100.0% [13] 18846(88.4%) 300(1.4%) loop ...herbie/simplify-tweak/src/points.rkt:145:4 loop [17] 96.7% ??? [18] 1.7% ------------------------------------------------------------------------- for-loop [10] 100.0% [14] 322(1.5%) 0(0.0%) map ...t-7.0/collects/racket/private/map.rkt:35:13 ??? [19] 100.0% ------------------------------------------------------------------------- argmin [11] 100.0% [15] 304(1.4%) 0(0.0%) ??? ...herbie/simplify-tweak/src/points.rkt:217:27 loop [20] 100.0% ------------------------------------------------------------------------- finalize-iter! [12] 100.0% [16] 300(1.4%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [21] 100.0% ------------------------------------------------------------------------- loop [13] 100.0% [17] 18218(85.4%) 636(3.0%) loop ...herbie/simplify-tweak/src/points.rkt:104:2 ??? [27] 93.2% ??? [31] 3.3% ------------------------------------------------------------------------- loop [13] 100.0% [18] 328(1.5%) 0(0.0%) ??? .../herbie/simplify-tweak/src/points.rkt:129:2 ??? [31] 100.0% ------------------------------------------------------------------------- map [14] 100.0% [19] 322(1.5%) 0(0.0%) ??? ...herbie/simplify-tweak/src/points.rkt:214:26 ??? [31] 100.0% ------------------------------------------------------------------------- ??? [15] 100.0% [20] 304(1.4%) 304(1.4%) loop .../racket-7.0/collects/racket/list.rkt:559:2 ------------------------------------------------------------------------- ??? [16] 100.0% [21] 300(1.4%) 0(0.0%) for-loop ...lify-tweak/src/core/alt-table.rkt:51:2 atab-add-altn [22] 100.0% ------------------------------------------------------------------------- for-loop [21] 100.0% [22] 300(1.4%) 0(0.0%) atab-add-altn ...weak/src/core/alt-table.rkt:200:0 best-and-tied-at-points [23] 100.0% ------------------------------------------------------------------------- atab-add-altn [22] 100.0% [23] 300(1.4%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:112:0 errors [24] 100.0% ------------------------------------------------------------------------- best-and-tied-at-points [23] 24.5% ??? [3] 75.5% [24] 1226(5.7%) 0(0.0%) errors ...rbie/simplify-tweak/src/points.rkt:228:0 for-loop [25] 75.5% eval-prog [26] 24.5% ------------------------------------------------------------------------- errors [24] 100.0% [25] 926(4.3%) 324(1.5%) for-loop ...ie/simplify-tweak/src/points.rkt:230:2 ??? [27] 32.8% ulp-difference [29] 32.2% ------------------------------------------------------------------------- errors [24] 100.0% [26] 300(1.4%) 0(0.0%) eval-prog ...simplify-tweak/src/programs.rkt:130:0 temp68_2 [28] 100.0% ------------------------------------------------------------------------- for-loop [25] 1.8% loop [17] 98.2% [27] 17276(81.0%) 0(0.0%) ??? ...erbie/simplify-tweak/src/programs.rkt:146:2 ??? [30] 90.6% ??? [31] 9.4% ------------------------------------------------------------------------- eval-prog [26] 100.0% [28] 300(1.4%) 0(0.0%) temp68_2 (unknown source) compile16 [32] 100.0% ------------------------------------------------------------------------- for-loop [25] 100.0% [29] 298(1.4%) 298(1.4%) ulp-difference ...implify-tweak/src/float.rkt:14:0 ------------------------------------------------------------------------- ??? [27] 100.0% [30] 15656(73.4%) 0(0.0%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 ??? [33] 100.0% ------------------------------------------------------------------------- ??? [19] 10.0% ??? [18] 10.2% for-loop [9] 10.4% loop [17] 19.0% ??? [27] 50.4% [31] 3214(15.1%) 930(4.4%) ??? ...tract/private/arrow-higher-order.rkt:357:33 mk-ival [34] 40.9% ->flonum [35] 30.1% ------------------------------------------------------------------------- temp68_2 [28] 100.0% [32] 300(1.4%) 0(0.0%) compile16 (unknown source) temp74_0 [36] 100.0% ------------------------------------------------------------------------- ??? [30] 100.0% [33] 15656(73.4%) 300(1.4%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-log [37] 83.0% ival-add [38] 15.0% ------------------------------------------------------------------------- ??? [31] 100.0% [34] 1316(6.2%) 0(0.0%) mk-ival ...simplify-tweak/src/biginterval.rkt:59:0 bf [39] 100.0% ------------------------------------------------------------------------- ??? [31] 100.0% [35] 968(4.5%) 334(1.6%) ->flonum ...e/simplify-tweak/src/programs.rkt:38:0 ??? [40] 33.3% return/no-unsupplied [41] 32.2% ------------------------------------------------------------------------- compile16 [32] 100.0% [36] 300(1.4%) 0(0.0%) temp74_0 (unknown source) expand-single [42] 100.0% ------------------------------------------------------------------------- ??? [33] 100.0% [37] 13000(60.9%) 300(1.4%) ival-log ...mplify-tweak/src/biginterval.rkt:179:0 ??? [43] 93.1% force [45] 2.3% ...higher-order.rkt:357:33 [46] 2.3% ------------------------------------------------------------------------- ??? [33] 100.0% [38] 2356(11.0%) 298(1.4%) ival-add ...implify-tweak/src/biginterval.rkt:87:0 ??? [43] 87.4% ------------------------------------------------------------------------- mk-ival [34] 100.0% [39] 1316(6.2%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [52] 77.2% ??? [53] 22.8% ------------------------------------------------------------------------- ->flonum [35] 100.0% [40] 322(1.5%) 322(1.5%) ??? ...s/racket/contract/private/arr-i.rkt:1252:29 ------------------------------------------------------------------------- ->flonum [35] 100.0% [41] 312(1.5%) 0(0.0%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 filter [44] 100.0% ------------------------------------------------------------------------- temp74_0 [36] 100.0% [42] 300(1.4%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [47] 100.0% ------------------------------------------------------------------------- ival-add [38] 14.5% ival-log [37] 85.5% [43] 14158(66.4%) 11128(52.2%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bflog [48] 13.7% bfadd [49] 7.7% ------------------------------------------------------------------------- return/no-unsupplied [41] 100.0% [44] 312(1.5%) 312(1.5%) filter ...0/collects/racket/private/list.rkt:256:2 ------------------------------------------------------------------------- ival-log [37] 100.0% [45] 300(1.4%) 300(1.4%) force ...collects/racket/private/promise.rkt:109:0 ------------------------------------------------------------------------- ival-log [37] 100.0% [46] 300(1.4%) 0(0.0%) ...higher-order.rkt:357:33 (unknown source) ??? [50] 100.0% ------------------------------------------------------------------------- expand-single [42] 100.0% [47] 300(1.4%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [51] 100.0% ------------------------------------------------------------------------- ??? [43] 100.0% [48] 1946(9.1%) 0(0.0%) bflog ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [52] 84.8% ??? [53] 15.2% ------------------------------------------------------------------------- ??? [43] 100.0% [49] 1084(5.1%) 334(1.6%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [52] 39.1% ??? [53] 30.1% ------------------------------------------------------------------------- ...higher-order.rkt:357:33 [46] 100.0% [50] 300(1.4%) 300(1.4%) ??? ...ects/racket/contract/private/guts.rkt:746:8 ------------------------------------------------------------------------- expand-capturing-lifts [47] 100.0% [51] 300(1.4%) 0(0.0%) lambda-clause-expander (unknown source) loop [54] 100.0% ------------------------------------------------------------------------- bfadd [49] 13.7% bf [39] 32.9% bflog [48] 53.4% [52] 3090(14.5%) 3090(14.5%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------- bflog [48] 32.1% bf [39] 32.5% bfadd [49] 35.4% [53] 922(4.3%) 922(4.3%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------- lambda-clause-expander [51] 100.0% [54] 300(1.4%) 0(0.0%) loop (unknown source) dispatch-transformer41 [55] 100.0% ------------------------------------------------------------------------- loop [54] 100.0% [55] 300(1.4%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [56] 100.0% ------------------------------------------------------------------------- dispatch-transformer41 [55] 100.0% [56] 300(1.4%) 0(0.0%) apply-transformer52 (unknown source) apply-transformer-in-context [57]100.0% ------------------------------------------------------------------------- apply-transformer52 [56] 100.0% [57] 300(1.4%) 0(0.0%) apply-transformer-in-context (unknown source) go [58] 100.0% ------------------------------------------------------------------------- apply-transformer-in-context [57]100.0% [58] 300(1.4%) 300(1.4%) go .../collects/racket/private/qq-and-or.rkt:50:20 -------------------------------------------------------------------------