Profiling results ----------------- Total cpu time observed: 10026ms (out of 10276ms) Number of samples taken: 27 (once every 371ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== ??? [5] 100.0% [1] 10026(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% ---------------------------------------------------------------------- ??? [5] 100.0% [2] 288(2.9%) 0(0.0%) oracle-error ...implify-tweak/src/points.rkt:212:0 for-loop [4] 100.0% ---------------------------------------------------------------------- profile-thunk16 [1] 100.0% [3] 10026(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [5] 100.0% ---------------------------------------------------------------------- oracle-error [2] 100.0% [4] 288(2.9%) 0(0.0%) for-loop ...ie/simplify-tweak/src/points.rkt:213:2 loop [6] 100.0% ---------------------------------------------------------------------- run [3] 50.0% [5] 10026(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% prepare-points-intervals [9] 41.2% run-improve40 [7] 5.8% eval-errors [8] 1.6% oracle-error [2] 1.4% ---------------------------------------------------------------------- parse-loop15 [38] 40.5% for-loop [4] 59.5% [6] 484(4.8%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:40:19 ??? [34] 59.5% hash-ref! [31] 40.5% ---------------------------------------------------------------------- ??? [5] 100.0% [7] 1162(11.6%) 0(0.0%) run-improve40 ...lify-tweak/src/mainloop.rkt:340:0 simplify! [10] 48.2% prepare-points-intervals [9] 34.9% for-loop [12] 16.9% ---------------------------------------------------------------------- ??? [5] 100.0% [8] 324(3.2%) 0(0.0%) eval-errors ...simplify-tweak/src/points.rkt:203:0 for-loop [11] 100.0% ---------------------------------------------------------------------- run-improve40 [7] 4.7% ??? [5] 95.3% [9] 8658(86.4%) 258(2.6%) prepare-points-intervals ...k/src/points.rkt:133:0 loop [13] 92.3% loop [18] 2.6% eval-prog [17] 2.1% ---------------------------------------------------------------------- run-improve40 [7] 100.0% [10] 560(5.6%) 0(0.0%) simplify! ...simplify-tweak/src/mainloop.rkt:217:0 ??? [14] 100.0% ---------------------------------------------------------------------- eval-errors [8] 100.0% [11] 324(3.2%) 0(0.0%) for-loop ...ie/simplify-tweak/src/points.rkt:205:2 ??? [15] 100.0% ---------------------------------------------------------------------- run-improve40 [7] 100.0% [12] 196(2.0%) 0(0.0%) for-loop .../simplify-tweak/src/mainloop.rkt:355:4 run-iter! [16] 100.0% ---------------------------------------------------------------------- prepare-points-intervals [9] 100.0% [13] 7994(79.7%) 0(0.0%) loop ...herbie/simplify-tweak/src/points.rkt:145:4 loop [18] 80.9% ??? [19] 19.1% ---------------------------------------------------------------------- simplify! [10] 100.0% [14] 560(5.6%) 0(0.0%) ??? ...e/simplify-tweak/src/core/simplify.rkt:26:0 one-iter [24] 54.3% for-loop [20] 45.7% ---------------------------------------------------------------------- for-loop [11] 100.0% [15] 324(3.2%) 324(3.2%) ??? ...7.0/collects/racket/private/for.rkt:1208:14 ---------------------------------------------------------------------- for-loop [12] 100.0% [16] 196(2.0%) 0(0.0%) run-iter! ...simplify-tweak/src/mainloop.rkt:321:0 localize! [21] 100.0% ---------------------------------------------------------------------- prepare-points-intervals [9] 100.0% [17] 180(1.8%) 0(0.0%) eval-prog ...simplify-tweak/src/programs.rkt:130:0 loop [22] 100.0% ---------------------------------------------------------------------- prepare-points-intervals [9] 3.4% loop [13] 96.6% [18] 6694(66.8%) 0(0.0%) loop ...herbie/simplify-tweak/src/points.rkt:104:2 ??? [23] 76.6% ??? [34] 23.4% ---------------------------------------------------------------------- loop [13] 100.0% [19] 1526(15.2%) 946(9.4%) ??? .../herbie/simplify-tweak/src/points.rkt:129:2 ??? [34] 38.0% ---------------------------------------------------------------------- ??? [14] 100.0% [20] 256(2.6%) 0(0.0%) for-loop ...plify-tweak/src/core/simplify.rkt:33:2 one-iter [24] 100.0% ---------------------------------------------------------------------- run-iter! [16] 100.0% [21] 196(2.0%) 0(0.0%) localize! ...simplify-tweak/src/mainloop.rkt:120:0 localize-error [25] 100.0% ---------------------------------------------------------------------- loop [22] 33.3% expand-capturing-lifts [26] 33.3% eval-prog [17] 33.3% [22] 180(1.8%) 0(0.0%) loop (unknown source) expand-capturing-lifts [26] 33.3% loop [22] 33.3% for-loop [27] 33.3% ---------------------------------------------------------------------- loop [18] 100.0% [23] 5128(51.1%) 0(0.0%) ??? ...erbie/simplify-tweak/src/programs.rkt:146:2 ??? [28] 85.3% ??? [34] 14.7% ---------------------------------------------------------------------- for-loop [20] 45.7% ??? [14] 54.3% [24] 560(5.6%) 0(0.0%) one-iter ...plify-tweak/src/core/simplify.rkt:86:0 find-matches [29] 54.3% for-loop [30] 45.7% ---------------------------------------------------------------------- localize! [21] 100.0% [25] 196(2.0%) 0(0.0%) localize-error ...tweak/src/core/localize.rkt:52:0 hash-ref! [31] 100.0% ---------------------------------------------------------------------- loop [22] 100.0% [26] 180(1.8%) 0(0.0%) expand-capturing-lifts (unknown source) loop [22] 100.0% ---------------------------------------------------------------------- run-module-instance!125 [33] 50.0% loop [22] 50.0% [27] 180(1.8%) 0(0.0%) for-loop (unknown source) run-module-instance!125 [33] 50.0% [running body] [32] 50.0% ---------------------------------------------------------------------- ??? [23] 100.0% [28] 4376(43.6%) 0(0.0%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 ??? [34] 82.3% ??? [35] 17.7% ---------------------------------------------------------------------- one-iter [24] 100.0% [29] 304(3.0%) 0(0.0%) find-matches ...y-tweak/src/core/simplify.rkt:56:0 for-loop [36] 100.0% ---------------------------------------------------------------------- one-iter [24] 100.0% [30] 256(2.6%) 0(0.0%) for-loop ...plify-tweak/src/core/simplify.rkt:95:2 apply-match [37] 100.0% ---------------------------------------------------------------------- loop [6] 50.0% localize-error [25] 50.0% [31] 196(2.0%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop15 [38] 100.0% ---------------------------------------------------------------------- for-loop [27] 100.0% [32] 180(1.8%) 180(1.8%) [running body] ...cts/racket/private/dict.rkt":##f ---------------------------------------------------------------------- for-loop [27] 100.0% [33] 180(1.8%) 0(0.0%) run-module-instance!125 (unknown source) for-loop [27] 100.0% ---------------------------------------------------------------------- loop [6] 4.2% ??? [19] 8.5% ??? [23] 11.1% loop [18] 23.1% ??? [28] 53.1% [34] 6788(67.7%) 1456(14.5%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ival-mult [39] 49.2% ->flonum [40] 23.1% mk-ival [42] 6.3% ---------------------------------------------------------------------- ??? [28] 100.0% [35] 774(7.7%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-add [41] 100.0% ---------------------------------------------------------------------- for-loop [36] 50.0% find-matches [29] 50.0% [36] 304(3.0%) 0(0.0%) for-loop ...plify-tweak/src/core/simplify.rkt:58:8 for-loop [36] 50.0% match-e [43] 50.0% ---------------------------------------------------------------------- for-loop [30] 100.0% [37] 256(2.6%) 0(0.0%) apply-match ...fy-tweak/src/core/simplify.rkt:65:0 set [44] 100.0% ---------------------------------------------------------------------- hash-ref! [31] 100.0% [38] 196(2.0%) 0(0.0%) parse-loop15 ...s/racket/match/compiler.rkt:418:15 loop [6] 50.0% loop [45] 50.0% ---------------------------------------------------------------------- ??? [34] 100.0% [39] 3338(33.3%) 0(0.0%) ival-mult ...plify-tweak/src/biginterval.rkt:105:0 bf* [46] 59.2% classify-ival [47] 40.8% ---------------------------------------------------------------------- ??? [34] 100.0% [40] 1566(15.6%) 0(0.0%) ->flonum ...e/simplify-tweak/src/programs.rkt:38:0 ??? [56] 100.0% ---------------------------------------------------------------------- ??? [35] 100.0% [41] 774(7.7%) 312(3.1%) ival-add ...implify-tweak/src/biginterval.rkt:87:0 ...higher-order.rkt:361:33 [50] 30.5% ??? [52] 29.2% ---------------------------------------------------------------------- ??? [34] 100.0% [42] 428(4.3%) 0(0.0%) mk-ival ...simplify-tweak/src/biginterval.rkt:59:0 bf [48] 100.0% ---------------------------------------------------------------------- for-loop [36] 100.0% [43] 304(3.0%) 304(3.0%) match-e ...simplify-tweak/src/core/ematch.rkt:39:0 ---------------------------------------------------------------------- apply-match [37] 100.0% [44] 256(2.6%) 0(0.0%) set ...collects/racket/private/set-types.rkt:981:0 for-loop [49] 100.0% ---------------------------------------------------------------------- parse-loop15 [38] 7.7% loop [45] 92.3% [45] 196(2.0%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:54:19 loop [45] 92.3% ulp-difference [51] 7.7% ---------------------------------------------------------------------- ival-mult [39] 100.0% [46] 1976(19.7%) 192(1.9%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [52] 90.3% ---------------------------------------------------------------------- ival-mult [39] 100.0% [47] 1362(13.6%) 1362(13.6%) classify-ival ...y-tweak/src/biginterval.rkt:310:0 ---------------------------------------------------------------------- mk-ival [42] 100.0% [48] 428(4.3%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [55] 100.0% ---------------------------------------------------------------------- set [44] 100.0% [49] 256(2.6%) 256(2.6%) for-loop ...cts/racket/private/set-types.rkt:937:4 ---------------------------------------------------------------------- ival-add [41] 100.0% [50] 236(2.4%) 236(2.4%) ...higher-order.rkt:361:33 (unknown source) ---------------------------------------------------------------------- loop [45] 100.0% [51] 196(2.0%) 0(0.0%) ulp-difference ...implify-tweak/src/float.rkt:14:0 return/no-unsupplied [53] 100.0% ---------------------------------------------------------------------- ival-add [41] 11.2% bf* [46] 88.8% [52] 2010(20.0%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfadd [54] 100.0% ---------------------------------------------------------------------- ulp-difference [51] 100.0% [53] 196(2.0%) 196(2.0%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 ---------------------------------------------------------------------- ??? [52] 100.0% [54] 2010(20.0%) 226(2.3%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [55] 79.4% ??? [56] 9.4% ---------------------------------------------------------------------- bf [48] 21.1% bfadd [54] 78.9% [55] 2024(20.2%) 2024(20.2%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ---------------------------------------------------------------------- bfadd [54] 10.7% ->flonum [40] 89.3% [56] 1754(17.5%) 1754(17.5%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 ----------------------------------------------------------------------