Profiling results ----------------- Total cpu time observed: 7942ms (out of 8196ms) Number of samples taken: 41 (once every 194ms) ======================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================== run [11] 50.0% [1] 7942(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [5] 50.0% loop [12] 44.8% run-improve50 [8] 5.2% ------------------------------------------------------------------------ loop [33] 100.0% [2] 6756(85.1%) 148(1.9%) ??? ...rbie/complex-support/src/programs.rkt:151:4 ??? [6] 65.0% ??? [7] 30.5% ??? [9] 2.2% ------------------------------------------------------------------------ loop [33] 100.0% [3] 166(2.1%) 0(0.0%) ??? ...ket/collects/racket/private/list.rkt:323:18 hash-ref! [31] 100.0% ------------------------------------------------------------------------ for-loop [40] 100.0% [4] 144(1.8%) 0(0.0%) match-e ...omplex-support/src/core/ematch.rkt:46:0 for-loop [10] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [5] 7942(100.0%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [11] 100.0% ------------------------------------------------------------------------ ??? [2] 100.0% [6] 4394(55.3%) 362(4.6%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [13] 91.8% ------------------------------------------------------------------------ ??? [2] 100.0% [7] 2062(26.0%) 632(8.0%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [14] 63.8% parse-loop12 [32] 5.5% ------------------------------------------------------------------------ ??? [1] 100.0% [8] 828(10.4%) 0(0.0%) run-improve50 ...ex-support/src/mainloop.rkt:235:0 setup-alt-simplified [15] 36.7% loop [12] 21.7% get-final-combination [16] 21.5% for-loop [17] 20.0% ------------------------------------------------------------------------ ??? [2] 100.0% [9] 152(1.9%) 152(1.9%) ??? ...tract/private/arrow-higher-order.rkt:145:21 ------------------------------------------------------------------------ match-e [4] 100.0% [10] 144(1.8%) 0(0.0%) for-loop ...plex-support/src/core/ematch.rkt:59:11 loop [33] 100.0% ------------------------------------------------------------------------ profile-thunk16 [5] 100.0% [11] 7942(100.0%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------ run-improve50 [8] 2.5% ??? [1] 97.5% [12] 7294(91.8%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:159:2 loop [24] 38.4% loop [18] 32.8% make-exacts* [25] 26.5% for-loop [23] 2.2% ------------------------------------------------------------------------ ??? [6] 100.0% [13] 4032(50.8%) 2984(37.6%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [26] 26.0% ------------------------------------------------------------------------ ??? [7] 100.0% [14] 1316(16.6%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfadd [19] 100.0% ------------------------------------------------------------------------ run-improve50 [8] 100.0% [15] 304(3.8%) 0(0.0%) setup-alt-simplified ...-support/src/glue.rkt:55:0 simplify-alt [20] 100.0% ------------------------------------------------------------------------ run-improve50 [8] 100.0% [16] 178(2.2%) 0(0.0%) get-final-combination ...rt/src/mainloop.rkt:265:0 extract-alt [21] 100.0% ------------------------------------------------------------------------ run-improve50 [8] 100.0% [17] 166(2.1%) 0(0.0%) for-loop ...omplex-support/src/mainloop.rkt:250:10 run-iter! [22] 100.0% ------------------------------------------------------------------------ loop [12] 100.0% [18] 2396(30.2%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:119:2 loop [24] 63.6% make-exacts* [25] 28.9% eval-prog [27] 7.5% ------------------------------------------------------------------------ ??? [14] 100.0% [19] 1316(16.6%) 740(9.3%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [26] 43.8% ------------------------------------------------------------------------ setup-alt-simplified [15] 100.0% [20] 304(3.8%) 0(0.0%) simplify-alt .../complex-support/src/glue.rkt:88:0 simplify [34] 100.0% ------------------------------------------------------------------------ get-final-combination [16] 100.0% [21] 178(2.2%) 0(0.0%) extract-alt ...e/complex-support/src/glue.rkt:61:0 loop [33] 100.0% ------------------------------------------------------------------------ for-loop [17] 100.0% [22] 166(2.1%) 0(0.0%) run-iter! ...omplex-support/src/mainloop.rkt:216:0 localize-error [28] 100.0% ------------------------------------------------------------------------ loop [12] 100.0% [23] 160(2.0%) 0(0.0%) for-loop .../complex-support/src/points.rkt:166:24 for-loop [29] 100.0% ------------------------------------------------------------------------ loop [18] 35.2% loop [12] 64.8% [24] 4328(54.5%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:109:4 loop [33] 53.1% map [30] 46.9% ------------------------------------------------------------------------ loop [18] 26.4% loop [12] 73.6% [25] 2626(33.1%) 0(0.0%) make-exacts* ...mplex-support/src/points.rkt:106:0 map [30] 57.3% loop [33] 42.7% ------------------------------------------------------------------------ bfadd [19] 35.5% real->bigfloat [13] 64.5% [26] 1624(20.4%) 1624(20.4%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ------------------------------------------------------------------------ loop [18] 100.0% [27] 180(2.3%) 0(0.0%) eval-prog ...omplex-support/src/programs.rkt:145:0 ??? [35] 100.0% ------------------------------------------------------------------------ run-iter! [22] 100.0% [28] 166(2.1%) 0(0.0%) localize-error ...pport/src/core/localize.rkt:47:0 hash-ref! [31] 100.0% ------------------------------------------------------------------------ for-loop [23] 100.0% [29] 160(2.0%) 160(2.0%) for-loop .../complex-support/src/points.rkt:167:26 ------------------------------------------------------------------------ make-exacts* [25] 42.6% loop [24] 57.4% [30] 3534(44.5%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 loop [33] 100.0% ------------------------------------------------------------------------ localize-error [28] 33.3% ??? [3] 66.7% [31] 166(2.1%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 parse-loop12 [32] 100.0% ------------------------------------------------------------------------ ??? [7] 40.7% hash-ref! [31] 59.3% [32] 280(3.5%) 114(1.4%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 loop [33] 59.3% ------------------------------------------------------------------------ make-exacts* [25] 0.0% loop [24] 0.1% parse-loop12 [32] 0.1% for-loop [10] 0.6% map [30] 1.2% extract-alt [21] 2.4% loop [33] 95.6% [33] 7442(93.7%) 310(3.9%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [33] 95.6% simplify [34] 2.4% ??? [2] 1.2% ??? [3] 0.1% ??? [35] 0.0% ------------------------------------------------------------------------ loop [33] 36.9% simplify-alt [20] 63.1% [34] 482(6.1%) 0(0.0%) simplify ...lex-support/src/core/simplify.rkt:39:0 iterate-egraph!5 [36] 100.0% ------------------------------------------------------------------------ eval-prog [27] 47.6% loop [33] 52.4% [35] 378(4.8%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:342:33 table-ref [47] 52.4% ??? [37] 47.6% ------------------------------------------------------------------------ simplify [34] 100.0% [36] 482(6.1%) 0(0.0%) iterate-egraph!5 ...ort/src/core/simplify.rkt:95:0 one-iter [38] 100.0% ------------------------------------------------------------------------ ??? [35] 100.0% [37] 180(2.3%) 180(2.3%) ??? ...tract/private/arrow-higher-order.rkt:336:46 ------------------------------------------------------------------------ iterate-egraph!5 [36] 100.0% [38] 482(6.1%) 0(0.0%) one-iter ...ex-support/src/core/simplify.rkt:106:0 loop [39] 70.1% for-loop [40] 29.9% ------------------------------------------------------------------------ one-iter [38] 100.0% [39] 338(4.3%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:52:19 apply-match [41] 100.0% ------------------------------------------------------------------------ for-loop [40] 50.0% one-iter [38] 50.0% [40] 144(1.8%) 0(0.0%) for-loop ...x-support/src/core/simplify.rkt:116:12 for-loop [40] 50.0% match-e [4] 50.0% ------------------------------------------------------------------------ loop [39] 100.0% [41] 338(4.3%) 0(0.0%) apply-match ...support/src/core/simplify.rkt:123:2 mk-enode! [43] 52.7% substitute-e [42] 47.3% ------------------------------------------------------------------------ apply-match [41] 100.0% [42] 160(2.0%) 0(0.0%) substitute-e ...x-support/src/core/ematch.rkt:71:0 mk-enode! [43] 100.0% ------------------------------------------------------------------------ substitute-e [42] 47.3% apply-match [41] 52.7% [43] 338(4.3%) 0(0.0%) mk-enode! ...lex-support/src/core/egraph.rkt:101:0 new-enode [44] 100.0% ------------------------------------------------------------------------ mk-enode! [43] 100.0% [44] 338(4.3%) 0(0.0%) new-enode ...mplex-support/src/core/enode.rkt:97:0 type-of-enode-expr [45] 100.0% ------------------------------------------------------------------------ new-enode [44] 100.0% [45] 338(4.3%) 0(0.0%) type-of-enode-expr ...port/src/core/enode.rkt:68:0 get-sigs [46] 100.0% ------------------------------------------------------------------------ type-of-enode-expr [45] 100.0% [46] 338(4.3%) 0(0.0%) get-sigs ...complex-support/src/type-check.rkt:5:0 table-ref [47] 52.7% ??? [48] 47.3% ------------------------------------------------------------------------ get-sigs [46] 47.3% ??? [35] 52.7% [47] 376(4.7%) 198(2.5%) table-ref .../racket/private/norm-define.rkt:53:83 ??? [49] 47.3% ------------------------------------------------------------------------ get-sigs [46] 100.0% [48] 160(2.0%) 0(0.0%) ??? ...ts/racket/contract/private/arr-i.rkt:804:10 get/build-late-neg-projection [50]100.0% ------------------------------------------------------------------------ table-ref [47] 100.0% [49] 178(2.2%) 178(2.2%) ??? ...ects/racket/contract/private/list.rkt:737:4 ------------------------------------------------------------------------ ??? [52] 50.0% ??? [48] 50.0% [50] 160(2.0%) 0(0.0%) get/build-late-neg-projection ...te/guts.rkt:691:0 ??? [52] 50.0% ??? [51] 50.0% ------------------------------------------------------------------------ get/build-late-neg-projection [50]100.0% [51] 160(2.0%) 0(0.0%) ??? ...cts/racket/contract/private/prop.rkt:314:12 build-compound-type-name [53] 100.0% ------------------------------------------------------------------------ get/build-late-neg-projection [50]100.0% [52] 160(2.0%) 0(0.0%) ??? ...ects/racket/contract/private/hash.rkt:211:2 get/build-late-neg-projection [50]100.0% ------------------------------------------------------------------------ ??? [51] 100.0% [53] 160(2.0%) 160(2.0%) build-compound-type-name ...private/guts.rkt:448:0 ------------------------------------------------------------------------