Profiling results ----------------- Total cpu time observed: 10496ms (out of 11256ms) Number of samples taken: 30 (once every 350ms) =============================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee =============================================================== run [7] 50.0% [1] 10496(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [4] 50.0% prepare-points [11] 34.9% run-improve48 [5] 15.1% --------------------------------------------------------------- loop [26] 100.0% [2] 1044(9.9%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ??? [12] 100.0% --------------------------------------------------------------- match-e [25] 100.0% [3] 360(3.4%) 0(0.0%) for-loop ...ean-out-code/src/core/ematch.rkt:59:11 for-loop [6] 100.0% --------------------------------------------------------------- ??? [1] 100.0% [4] 10496(100.0%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [7] 100.0% --------------------------------------------------------------- ??? [1] 100.0% [5] 3172(30.2%) 0(0.0%) run-improve48 ...n-out-code/src/mainloop.rkt:286:0 for-loop [8] 77.9% setup-prog!41 [9] 12.9% for-loop [10] 9.2% --------------------------------------------------------------- for-loop [3] 100.0% [6] 360(3.4%) 0(0.0%) for-loop ...ean-out-code/src/core/ematch.rkt:65:37 match-e [25] 100.0% --------------------------------------------------------------- profile-thunk16 [4] 100.0% [7] 10496(100.0%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% --------------------------------------------------------------- run-improve48 [5] 100.0% [8] 2472(23.6%) 0(0.0%) for-loop ...clean-out-code/src/mainloop.rkt:298:29 ??? [12] 100.0% --------------------------------------------------------------- run-improve48 [5] 100.0% [9] 408(3.9%) 0(0.0%) setup-prog!41 ...an-out-code/src/mainloop.rkt:63:0 prepare-points [11] 100.0% --------------------------------------------------------------- run-improve48 [5] 100.0% [10] 292(2.8%) 0(0.0%) for-loop .../clean-out-code/src/mainloop.rkt:303:8 run-iter! [13] 100.0% --------------------------------------------------------------- setup-prog!41 [9] 5.3% ??? [1] 94.7% [11] 7732(73.7%) 0(0.0%) prepare-points ...an-out-code/src/points.rkt:156:0 make-exacts* [17] 36.7% loop [14] 35.9% loop [18] 27.5% --------------------------------------------------------------- ??? [2] 29.7% for-loop [8] 70.3% [12] 3516(33.5%) 1044(9.9%) ??? ...llects/racket/private/norm-define.rkt:53:83 iterate-egraph!7 [15] 70.3% --------------------------------------------------------------- for-loop [10] 100.0% [13] 292(2.8%) 0(0.0%) run-iter! ...clean-out-code/src/mainloop.rkt:267:0 localize-error [16] 100.0% --------------------------------------------------------------- prepare-points [11] 100.0% [14] 2772(26.4%) 0(0.0%) loop ...herbie/clean-out-code/src/points.rkt:124:2 loop [18] 51.7% make-exacts* [17] 48.3% --------------------------------------------------------------- ??? [12] 100.0% [15] 2472(23.6%) 0(0.0%) iterate-egraph!7 ...ode/src/core/simplify.rkt:55:0 one-iter [19] 100.0% --------------------------------------------------------------- run-iter! [13] 100.0% [16] 292(2.8%) 0(0.0%) localize-error ...-code/src/core/localize.rkt:47:0 hash-ref! [20] 100.0% --------------------------------------------------------------- loop [14] 32.1% prepare-points [11] 67.9% [17] 4176(39.8%) 0(0.0%) make-exacts* ...lean-out-code/src/points.rkt:104:0 loop [26] 100.0% --------------------------------------------------------------- loop [14] 40.3% prepare-points [11] 59.7% [18] 3556(33.9%) 0(0.0%) loop ...herbie/clean-out-code/src/points.rkt:107:4 loop [26] 100.0% --------------------------------------------------------------- iterate-egraph!7 [15] 100.0% [19] 2472(23.6%) 0(0.0%) one-iter ...an-out-code/src/core/simplify.rkt:66:0 for-loop [21] 85.4% for-loop [22] 14.6% --------------------------------------------------------------- localize-error [16] 100.0% [20] 292(2.8%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 parse-loop12 [23] 100.0% --------------------------------------------------------------- one-iter [19] 100.0% [21] 2112(20.1%) 0(0.0%) for-loop ...n-out-code/src/core/simplify.rkt:117:2 for-loop [24] 100.0% --------------------------------------------------------------- for-loop [22] 50.0% one-iter [19] 50.0% [22] 360(3.4%) 0(0.0%) for-loop ...n-out-code/src/core/simplify.rkt:76:12 for-loop [22] 50.0% match-e [25] 50.0% --------------------------------------------------------------- hash-ref! [20] 100.0% [23] 292(2.8%) 0(0.0%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 loop [26] 100.0% --------------------------------------------------------------- for-loop [21] 100.0% [24] 2112(20.1%) 0(0.0%) for-loop ...n-out-code/src/core/simplify.rkt:99:10 loop! [30] 49.0% substitute-e [27] 17.9% merge-egraph-nodes! [28] 16.8% mk-enode! [31] 16.4% --------------------------------------------------------------- for-loop [6] 50.0% for-loop [22] 50.0% [25] 360(3.4%) 0(0.0%) match-e ...clean-out-code/src/core/ematch.rkt:46:0 for-loop [3] 50.0% loop [26] 50.0% --------------------------------------------------------------- loop [18] 0.2% make-exacts* [17] 0.3% parse-loop12 [23] 0.4% loop! [30] 1.9% match-e [25] 4.1% loop [26] 93.0% [26] 8712(83.0%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [26] 93.0% foldl [32] 4.1% loop! [30] 1.9% ??? [29] 0.5% bf* [38] 0.4% ??? [2] 0.0% --------------------------------------------------------------- for-loop [24] 100.0% [27] 378(3.6%) 0(0.0%) substitute-e ...-out-code/src/core/ematch.rkt:71:0 mk-enode! [31] 100.0% --------------------------------------------------------------- for-loop [24] 100.0% [28] 354(3.4%) 0(0.0%) merge-egraph-nodes! ...e/src/core/egraph.rkt:153:0 update-leader! [33] 100.0% --------------------------------------------------------------- loop [26] 100.0% [29] 6688(63.7%) 0(0.0%) ??? ...erbie/clean-out-code/src/programs.rkt:129:2 ??? [34] 100.0% --------------------------------------------------------------- loop [26] 15.9% for-loop [24] 84.1% [30] 1034(9.9%) 328(3.1%) loop! ...e/clean-out-code/src/core/enode.rkt:190:2 custom-set-union [35] 68.3% loop [26] 15.9% --------------------------------------------------------------- for-loop [24] 47.8% substitute-e [27] 52.2% [31] 724(6.9%) 378(3.6%) mk-enode! ...an-out-code/src/core/egraph.rkt:102:0 hash-has-key? [37] 47.8% --------------------------------------------------------------- loop [26] 100.0% [32] 360(3.4%) 360(3.4%) foldl ...et/collects/racket/private/list.rkt:229:4 --------------------------------------------------------------- merge-egraph-nodes! [28]100.0% [33] 354(3.4%) 0(0.0%) update-leader! ...t-code/src/core/egraph.rkt:218:0 for-loop [36] 100.0% --------------------------------------------------------------- ??? [29] 100.0% [34] 6688(63.7%) 2080(19.8%) ??? ...acket/collects/racket/private/kw.rkt:444:14 bf* [38] 53.5% ??? [41] 15.4% --------------------------------------------------------------- loop! [30] 100.0% [35] 706(6.7%) 360(3.4%) custom-set-union ...et/private/set-types.rkt:168:0 for-loop [40] 49.0% --------------------------------------------------------------- update-leader! [33] 100.0% [36] 354(3.4%) 0(0.0%) for-loop ...ean-out-code/src/core/egraph.rkt:223:6 for-loop [39] 100.0% --------------------------------------------------------------- mk-enode! [31] 100.0% [37] 346(3.3%) 346(3.3%) hash-has-key? ...et/private/more-scheme.rkt:368:13 --------------------------------------------------------------- loop [26] 7.5% ??? [34] 92.5% [38] 3872(36.9%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [41] 100.0% --------------------------------------------------------------- for-loop [36] 100.0% [39] 354(3.4%) 0(0.0%) for-loop ...ean-out-code/src/core/egraph.rkt:224:8 hash-update! [42] 100.0% --------------------------------------------------------------- custom-set-union [35] 100.0% [40] 346(3.3%) 346(3.3%) for-loop ...cts/racket/private/set-types.rkt:174:3 --------------------------------------------------------------- ??? [34] 21.0% bf* [38] 79.0% [41] 4900(46.7%) 368(3.5%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [43] 92.5% --------------------------------------------------------------- for-loop [39] 100.0% [42] 354(3.4%) 0(0.0%) hash-update! ...ket/private/more-scheme.rkt:362:13 ??? [44] 100.0% --------------------------------------------------------------- ??? [41] 100.0% [43] 4532(43.2%) 3194(30.4%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [45] 29.5% --------------------------------------------------------------- hash-update! [42] 100.0% [44] 354(3.4%) 0(0.0%) ??? ...e/clean-out-code/src/core/egraph.rkt:226:24 for-loop [46] 100.0% --------------------------------------------------------------- bfmul [43] 100.0% [45] 1338(12.7%) 1338(12.7%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 --------------------------------------------------------------- ??? [44] 100.0% [46] 354(3.4%) 354(3.4%) for-loop ...an-out-code/src/core/egraph.rkt:227:26 ---------------------------------------------------------------