Profiling results ----------------- Total cpu time observed: 17932ms (out of 18352ms) Number of samples taken: 168 (once every 107ms) ======================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================== ??? [11] 100.0% [1] 17686(98.6%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% ------------------------------------------------------------------------ ??? [11] 100.0% [2] 1826(10.2%) 0(0.0%) run-improve50 ...ex-support/src/mainloop.rkt:235:0 setup-alt-simplified [6] 35.0% get-final-combination [8] 27.9% loop [15] 27.7% for-loop [9] 9.3% ------------------------------------------------------------------------ match-e [56] 100.0% [3] 378(2.1%) 92(0.5%) for-loop ...plex-support/src/core/ematch.rkt:59:11 for-loop [7] 75.4% list-cartesian-product [10] 12.4% ------------------------------------------------------------------------ loop [29] 100.0% [4] 84(0.5%) 0(0.0%) ??? ...ket/collects/racket/private/list.rkt:323:18 hash-ref! [19] 100.0% ------------------------------------------------------------------------ profile-thunk16 [1] 99.1% [5] 17852(99.6%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [11] 100.0% ------------------------------------------------------------------------ run-improve50 [2] 100.0% [6] 640(3.6%) 0(0.0%) setup-alt-simplified ...-support/src/glue.rkt:55:0 simplify-alt [12] 100.0% ------------------------------------------------------------------------ match-e [56] 33.9% for-loop [3] 66.1% [7] 572(3.2%) 0(0.0%) for-loop ...plex-support/src/core/ematch.rkt:65:37 match-e [56] 100.0% ------------------------------------------------------------------------ run-improve50 [2] 100.0% [8] 510(2.8%) 0(0.0%) get-final-combination ...rt/src/mainloop.rkt:265:0 extract-alt [13] 100.0% ------------------------------------------------------------------------ run-improve50 [2] 100.0% [9] 170(0.9%) 0(0.0%) for-loop ...omplex-support/src/mainloop.rkt:250:10 run-iter! [14] 100.0% ------------------------------------------------------------------------ list-cartesian-product [10] 50.0% for-loop [3] 50.0% [10] 94(0.5%) 94(0.5%) list-cartesian-product ...src/core/ematch.rkt:20:0 list-cartesian-product [10] 50.0% ------------------------------------------------------------------------ run [5] 50.2% [11] 17932(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 49.3% loop [15] 45.6% run-improve50 [2] 5.1% ------------------------------------------------------------------------ setup-alt-simplified [6] 100.0% [12] 640(3.6%) 0(0.0%) simplify-alt .../complex-support/src/glue.rkt:88:0 simplify [31] 100.0% ------------------------------------------------------------------------ get-final-combination [8] 100.0% [13] 510(2.8%) 0(0.0%) extract-alt ...e/complex-support/src/glue.rkt:61:0 loop [29] 100.0% ------------------------------------------------------------------------ for-loop [9] 100.0% [14] 170(0.9%) 0(0.0%) run-iter! ...omplex-support/src/mainloop.rkt:216:0 localize-error [16] 100.0% ------------------------------------------------------------------------ run-improve50 [2] 3.0% ??? [11] 97.0% [15] 16612(92.6%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:159:2 loop [17] 46.5% loop [20] 26.9% make-exacts* [21] 25.5% for-loop [18] 1.1% ------------------------------------------------------------------------ run-iter! [14] 100.0% [16] 170(0.9%) 0(0.0%) localize-error ...pport/src/core/localize.rkt:47:0 hash-ref! [19] 100.0% ------------------------------------------------------------------------ loop [15] 100.0% [17] 7718(43.0%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:119:2 loop [20] 79.0% make-exacts* [21] 14.5% eval-prog [22] 5.0% loop [25] 1.6% ------------------------------------------------------------------------ loop [15] 100.0% [18] 184(1.0%) 0(0.0%) for-loop .../complex-support/src/points.rkt:166:24 for-loop [23] 100.0% ------------------------------------------------------------------------ ??? [4] 32.9% localize-error [16] 67.1% [19] 170(0.9%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 parse-loop12 [24] 100.0% ------------------------------------------------------------------------ loop [15] 42.3% loop [17] 57.7% [20] 10560(58.9%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:109:4 map [26] 71.2% loop [29] 28.8% ------------------------------------------------------------------------ loop [17] 20.8% loop [15] 79.2% [21] 5360(29.9%) 66(0.4%) make-exacts* ...mplex-support/src/points.rkt:106:0 loop [29] 63.0% map [26] 35.8% ------------------------------------------------------------------------ loop [17] 100.0% [22] 386(2.2%) 0(0.0%) eval-prog ...omplex-support/src/programs.rkt:145:0 [running body] [27] 61.1% ??? [32] 38.9% ------------------------------------------------------------------------ for-loop [18] 100.0% [23] 184(1.0%) 88(0.5%) for-loop .../complex-support/src/points.rkt:167:26 ??? [28] 52.2% ------------------------------------------------------------------------ hash-ref! [19] 100.0% [24] 170(0.9%) 0(0.0%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 table-ref [36] 50.6% loop [29] 49.4% ------------------------------------------------------------------------ loop [17] 0.1% loop [25] 99.9% [25] 122(0.7%) 122(0.7%) loop ...herbie/complex-support/src/points.rkt:98:2 loop [25] 99.9% ------------------------------------------------------------------------ make-exacts* [21] 20.3% loop [20] 79.7% [26] 9440(52.6%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 loop [29] 99.3% ??? [30] 0.7% ------------------------------------------------------------------------ eval-prog [22] 100.0% [27] 236(1.3%) 236(1.3%) [running body] ...collects/syntax/id-table.rkt:##f ------------------------------------------------------------------------ for-loop [23] 100.0% [28] 96(0.5%) 96(0.5%) ??? ...herbie/complex-support/src/points.rkt:156:9 ------------------------------------------------------------------------ parse-loop12 [24] 0.0% loop [20] 0.0% make-exacts* [21] 0.1% map [26] 1.7% extract-alt [13] 3.1% loop [29] 95.1% [29] 16384(91.4%) 128(0.7%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [29] 95.1% simplify [31] 3.1% ??? [30] 1.8% ??? [4] 0.0% ??? [41] 0.0% ??? [32] 0.0% ------------------------------------------------------------------------ map [26] 0.4% loop [29] 99.6% [30] 14858(82.9%) 936(5.2%) ??? ...rbie/complex-support/src/programs.rkt:151:4 ??? [33] 50.5% ??? [34] 38.8% ??? [37] 4.4% ------------------------------------------------------------------------ loop [29] 44.3% simplify-alt [12] 55.7% [31] 1150(6.4%) 0(0.0%) simplify ...lex-support/src/core/simplify.rkt:39:0 iterate-egraph!5 [35] 93.6% mk-egraph [39] 6.4% ------------------------------------------------------------------------ eval-prog [22] 14.7% loop [29] 85.3% [32] 1018(5.7%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:342:33 table-ref [36] 85.3% ??? [38] 14.7% ------------------------------------------------------------------------ ??? [30] 100.0% [33] 7504(41.8%) 2032(11.3%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [41] 60.3% ...higher-order.rkt:346:33 [43] 10.0% ??? [45] 2.6% ------------------------------------------------------------------------ ??? [30] 100.0% [34] 5768(32.2%) 436(2.4%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [40] 92.4% ------------------------------------------------------------------------ simplify [31] 100.0% [35] 1076(6.0%) 0(0.0%) iterate-egraph!5 ...ort/src/core/simplify.rkt:95:0 one-iter [42] 100.0% ------------------------------------------------------------------------ parse-loop12 [24] 9.0% ??? [32] 91.0% [36] 954(5.3%) 242(1.3%) table-ref .../racket/private/norm-define.rkt:53:83 ??? [44] 59.1% ??? [46] 9.0% ??? [48] 6.5% ------------------------------------------------------------------------ ??? [30] 100.0% [37] 650(3.6%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:145:21 ??? [81] 100.0% ------------------------------------------------------------------------ ??? [32] 100.0% [38] 150(0.8%) 150(0.8%) ??? ...tract/private/arrow-higher-order.rkt:336:46 ------------------------------------------------------------------------ simplify [31] 100.0% [39] 74(0.4%) 0(0.0%) mk-egraph ...lex-support/src/core/egraph.rkt:123:0 expr->enode [47] 100.0% ------------------------------------------------------------------------ ??? [34] 100.0% [40] 5332(29.7%) 4276(23.8%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [53] 19.8% ------------------------------------------------------------------------ loop [29] 1.8% ??? [33] 98.2% [41] 4610(25.7%) 234(1.3%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfadd [49] 94.9% ------------------------------------------------------------------------ iterate-egraph!5 [35] 100.0% [42] 1076(6.0%) 0(0.0%) one-iter ...ex-support/src/core/simplify.rkt:106:0 loop [50] 57.6% for-loop [52] 34.6% apply-match [54] 7.8% ------------------------------------------------------------------------ ??? [33] 100.0% [43] 748(4.2%) 64(0.4%) ...higher-order.rkt:346:33 (unknown source) ??? [77] 91.4% ------------------------------------------------------------------------ table-ref [36] 100.0% [44] 564(3.1%) 92(0.5%) ??? .../herbie/complex-support/src/config.rkt:48:0 ??? [51] 83.7% ------------------------------------------------------------------------ ??? [33] 100.0% [45] 198(1.1%) 198(1.1%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 ------------------------------------------------------------------------ table-ref [36] 100.0% [46] 86(0.5%) 86(0.5%) ??? ...ects/racket/contract/private/list.rkt:737:4 ------------------------------------------------------------------------ mk-egraph [39] 100.0% [47] 74(0.4%) 0(0.0%) expr->enode ...x-support/src/core/egraph.rkt:124:2 mk-enode! [59] 100.0% ------------------------------------------------------------------------ table-ref [36] 100.0% [48] 62(0.3%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:60:15 ??? [53] 100.0% ------------------------------------------------------------------------ ??? [41] 100.0% [49] 4376(24.4%) 3078(17.2%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [53] 29.7% ------------------------------------------------------------------------ one-iter [42] 100.0% [50] 620(3.5%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:52:19 apply-match [54] 100.0% ------------------------------------------------------------------------ ??? [44] 100.0% [51] 472(2.6%) 94(0.5%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [55] 80.1% ------------------------------------------------------------------------ for-loop [52] 50.0% one-iter [42] 50.0% [52] 372(2.1%) 86(0.5%) for-loop ...x-support/src/core/simplify.rkt:116:12 for-loop [52] 50.0% match-e [56] 38.4% ------------------------------------------------------------------------ ??? [48] 2.6% real->bigfloat [40] 43.7% bfadd [49] 53.7% [53] 2416(13.5%) 2416(13.5%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ------------------------------------------------------------------------ one-iter [42] 11.9% loop [50] 88.1% [54] 704(3.9%) 0(0.0%) apply-match ...support/src/core/simplify.rkt:123:2 match-e [56] 40.6% merge-egraph-nodes! [57] 24.1% mk-enode! [59] 23.3% substitute-e [58] 11.9% ------------------------------------------------------------------------ ??? [51] 100.0% [55] 378(2.1%) 378(2.1%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 ------------------------------------------------------------------------ for-loop [52] 25.0% apply-match [54] 25.0% for-loop [7] 50.0% [56] 572(3.2%) 184(1.0%) match-e ...omplex-support/src/core/ematch.rkt:46:0 for-loop [3] 49.3% variable? [60] 17.7% for-loop [7] 17.0% ------------------------------------------------------------------------ apply-match [54] 100.0% [57] 170(0.9%) 0(0.0%) merge-egraph-nodes! ...t/src/core/egraph.rkt:152:0 for-loop [61] 57.6% update-leader! [62] 42.4% ------------------------------------------------------------------------ apply-match [54] 100.0% [58] 84(0.5%) 0(0.0%) substitute-e ...x-support/src/core/ematch.rkt:71:0 mk-enode! [59] 100.0% ------------------------------------------------------------------------ expr->enode [47] 23.0% substitute-e [58] 26.1% apply-match [54] 50.9% [59] 322(1.8%) 0(0.0%) mk-enode! ...lex-support/src/core/egraph.rkt:101:0 new-enode [63] 100.0% ------------------------------------------------------------------------ match-e [56] 100.0% [60] 202(1.1%) 0(0.0%) variable? ...x-support/src/syntax/syntax.rkt:659:0 ??? [64] 100.0% ------------------------------------------------------------------------ merge-egraph-nodes! [57] 100.0% [61] 98(0.5%) 98(0.5%) for-loop ...plex-support/src/core/egraph.rkt:232:6 ------------------------------------------------------------------------ merge-egraph-nodes! [57] 100.0% [62] 72(0.4%) 0(0.0%) update-leader! ...upport/src/core/egraph.rkt:217:0 for-loop [65] 100.0% ------------------------------------------------------------------------ mk-enode! [59] 100.0% [63] 322(1.8%) 0(0.0%) new-enode ...mplex-support/src/core/enode.rkt:97:0 type-of-enode-expr [66] 100.0% ------------------------------------------------------------------------ variable? [60] 100.0% [64] 202(1.1%) 202(1.1%) ??? ...contract/private/arrow-val-first.rkt:357:18 ------------------------------------------------------------------------ update-leader! [62] 100.0% [65] 72(0.4%) 0(0.0%) for-loop ...plex-support/src/core/egraph.rkt:222:6 for-loop [67] 100.0% ------------------------------------------------------------------------ new-enode [63] 100.0% [66] 322(1.8%) 0(0.0%) type-of-enode-expr ...port/src/core/enode.rkt:68:0 get-sigs [68] 100.0% ------------------------------------------------------------------------ for-loop [65] 100.0% [67] 72(0.4%) 0(0.0%) for-loop ...plex-support/src/core/egraph.rkt:223:8 hash-update! [69] 100.0% ------------------------------------------------------------------------ type-of-enode-expr [66] 100.0% [68] 322(1.8%) 0(0.0%) get-sigs ...complex-support/src/type-check.rkt:5:0 ??? [70] 52.8% ...pport/src/common.rkt:46:2 [71] 47.2% ------------------------------------------------------------------------ for-loop [67] 100.0% [69] 72(0.4%) 0(0.0%) hash-update! ...ket/private/more-scheme.rkt:362:13 ??? [72] 100.0% ------------------------------------------------------------------------ get-sigs [68] 100.0% [70] 170(0.9%) 0(0.0%) ??? ...ts/racket/contract/private/arr-i.rkt:804:10 for-loop [73] 100.0% ------------------------------------------------------------------------ get-sigs [68] 100.0% [71] 152(0.8%) 0(0.0%) ...pport/src/common.rkt:46:2 ...e/arr-i.rkt:906:19 ??? [74] 55.3% ??? [76] 44.7% ------------------------------------------------------------------------ hash-update! [69] 100.0% [72] 72(0.4%) 0(0.0%) ??? .../complex-support/src/core/egraph.rkt:225:24 for-loop [75] 100.0% ------------------------------------------------------------------------ ??? [70] 100.0% [73] 170(0.9%) 0(0.0%) for-loop ...racket/contract/private/hash.rkt:239:6 ??? [77] 100.0% ------------------------------------------------------------------------ ...pport/src/common.rkt:46:2 [71]100.0% [74] 84(0.5%) 0(0.0%) ??? ...s/racket/contract/private/arr-i.rkt:1268:39 assoc-ref [78] 100.0% ------------------------------------------------------------------------ ??? [72] 100.0% [75] 72(0.4%) 0(0.0%) for-loop ...lex-support/src/core/egraph.rkt:226:26 update-en-expr [79] 100.0% ------------------------------------------------------------------------ ...pport/src/common.rkt:46:2 [71]100.0% [76] 68(0.4%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:342:4 ??? [77] 100.0% ------------------------------------------------------------------------ ??? [76] 7.4% for-loop [73] 18.4% ...higher-order.rkt:346:33 [43] 74.2% [77] 922(5.1%) 680(3.8%) ??? ...cts/racket/contract/private/list.rkt:187:10 ??? [80] 18.4% ??? [81] 7.8% ------------------------------------------------------------------------ ??? [74] 100.0% [78] 84(0.5%) 84(0.5%) assoc-ref ...collects/racket/private/dict.rkt:56:0 ------------------------------------------------------------------------ for-loop [75] 100.0% [79] 72(0.4%) 72(0.4%) update-en-expr ...upport/src/core/egraph.rkt:211:0 ------------------------------------------------------------------------ ??? [77] 100.0% [80] 170(0.9%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:686:7 ??? [81] 100.0% ------------------------------------------------------------------------ ??? [77] 8.1% ??? [80] 19.1% ??? [37] 72.9% [81] 892(5.0%) 892(5.0%) ??? ...ects/racket/contract/private/guts.rkt:644:8 ------------------------------------------------------------------------