Profiling results ----------------- Total cpu time observed: 6522ms (out of 6788ms) Number of samples taken: 33 (once every 198ms) ===================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ===================================================================== ??? [5] 100.0% [1] 6354(97.4%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% --------------------------------------------------------------------- match-e [39] 100.0% [2] 310(4.8%) 148(2.3%) for-loop ...plex-support/src/core/ematch.rkt:59:11 for-loop [4] 76.1% --------------------------------------------------------------------- profile-thunk16 [1] 97.4% [3] 6522(100.0%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [5] 100.0% --------------------------------------------------------------------- for-loop [2] 100.0% [4] 310(4.8%) 0(0.0%) for-loop ...plex-support/src/core/ematch.rkt:65:37 match-e [39] 100.0% --------------------------------------------------------------------- run [3] 51.3% [5] 6522(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 48.7% loop [7] 44.1% run-improve50 [6] 7.2% --------------------------------------------------------------------- ??? [5] 100.0% [6] 942(14.4%) 0(0.0%) run-improve50 ...ex-support/src/mainloop.rkt:235:0 setup-alt-simplified [8] 32.9% get-final-combination [9] 31.8% loop [7] 19.1% for-loop [10] 16.1% --------------------------------------------------------------------- run-improve50 [6] 3.1% ??? [5] 96.9% [7] 5760(88.3%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:159:2 loop [11] 62.6% make-exacts* [17] 34.4% for-loop [14] 2.9% --------------------------------------------------------------------- run-improve50 [6] 100.0% [8] 310(4.8%) 0(0.0%) setup-alt-simplified ...-support/src/glue.rkt:55:0 simplify-alt [12] 100.0% --------------------------------------------------------------------- run-improve50 [6] 100.0% [9] 300(4.6%) 0(0.0%) get-final-combination ...rt/src/mainloop.rkt:265:0 extract-alt [13] 100.0% --------------------------------------------------------------------- run-improve50 [6] 100.0% [10] 152(2.3%) 0(0.0%) for-loop ...omplex-support/src/mainloop.rkt:250:10 run-iter! [15] 100.0% --------------------------------------------------------------------- loop [7] 100.0% [11] 3608(55.3%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:119:2 loop [16] 80.7% make-exacts* [17] 14.4% eval-prog [18] 5.0% --------------------------------------------------------------------- setup-alt-simplified [8] 100.0% [12] 310(4.8%) 0(0.0%) simplify-alt .../complex-support/src/glue.rkt:88:0 simplify [25] 100.0% --------------------------------------------------------------------- get-final-combination [9] 100.0% [13] 300(4.6%) 0(0.0%) extract-alt ...e/complex-support/src/glue.rkt:61:0 loop [23] 100.0% --------------------------------------------------------------------- loop [7] 100.0% [14] 168(2.6%) 0(0.0%) for-loop .../complex-support/src/points.rkt:166:24 for-loop [19] 100.0% --------------------------------------------------------------------- for-loop [10] 100.0% [15] 152(2.3%) 0(0.0%) run-iter! ...omplex-support/src/mainloop.rkt:216:0 choose-best-alt! [20] 100.0% --------------------------------------------------------------------- loop [11] 100.0% [16] 2910(44.6%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:109:4 loop [23] 57.8% map [21] 42.2% --------------------------------------------------------------------- loop [11] 20.7% loop [7] 79.3% [17] 2502(38.4%) 0(0.0%) make-exacts* ...mplex-support/src/points.rkt:106:0 loop [23] 55.3% map [21] 44.7% --------------------------------------------------------------------- loop [11] 100.0% [18] 180(2.8%) 0(0.0%) eval-prog ...omplex-support/src/programs.rkt:145:0 ??? [49] 100.0% --------------------------------------------------------------------- for-loop [14] 100.0% [19] 168(2.6%) 0(0.0%) for-loop .../complex-support/src/points.rkt:167:26 ??? [22] 100.0% --------------------------------------------------------------------- run-iter! [15] 100.0% [20] 152(2.3%) 0(0.0%) choose-best-alt! ...support/src/mainloop.rkt:116:0 ??? [46] 100.0% --------------------------------------------------------------------- make-exacts* [17] 47.7% loop [16] 52.3% [21] 2346(36.0%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 loop [23] 100.0% --------------------------------------------------------------------- for-loop [19] 100.0% [22] 168(2.6%) 168(2.6%) ??? ...herbie/complex-support/src/points.rkt:156:9 --------------------------------------------------------------------- loop [16] 0.2% make-exacts* [17] 0.2% map [21] 0.2% extract-alt [13] 5.3% loop [23] 94.2% [23] 5712(87.6%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [23] 94.2% simplify [25] 5.3% ??? [24] 0.6% --------------------------------------------------------------------- loop [23] 100.0% [24] 5412(83.0%) 0(0.0%) ??? ...rbie/complex-support/src/programs.rkt:151:4 ??? [26] 51.1% ??? [27] 48.9% --------------------------------------------------------------------- loop [23] 49.2% simplify-alt [12] 50.8% [25] 610(9.4%) 0(0.0%) simplify ...lex-support/src/core/simplify.rkt:39:0 iterate-egraph!5 [28] 100.0% --------------------------------------------------------------------- ??? [24] 100.0% [26] 2766(42.4%) 836(12.8%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [30] 57.5% ...higher-order.rkt:346:33 [32] 12.3% --------------------------------------------------------------------- ??? [24] 100.0% [27] 2646(40.6%) 0(0.0%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [29] 100.0% --------------------------------------------------------------------- simplify [25] 100.0% [28] 610(9.4%) 0(0.0%) iterate-egraph!5 ...ort/src/core/simplify.rkt:95:0 one-iter [31] 100.0% --------------------------------------------------------------------- ??? [27] 100.0% [29] 2646(40.6%) 1726(26.5%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [37] 34.8% --------------------------------------------------------------------- ??? [26] 100.0% [30] 1590(24.4%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfadd [33] 100.0% --------------------------------------------------------------------- iterate-egraph!5 [28] 100.0% [31] 610(9.4%) 0(0.0%) one-iter ...ex-support/src/core/simplify.rkt:106:0 loop [34] 75.7% for-loop [36] 24.3% --------------------------------------------------------------------- ??? [26] 100.0% [32] 340(5.2%) 162(2.5%) ...higher-order.rkt:346:33 (unknown source) ??? [35] 52.4% --------------------------------------------------------------------- ??? [30] 100.0% [33] 1590(24.4%) 1156(17.7%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [37] 27.3% --------------------------------------------------------------------- one-iter [31] 100.0% [34] 462(7.1%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:52:19 apply-match [38] 100.0% --------------------------------------------------------------------- ...higher-order.rkt:346:33 [32]100.0% [35] 178(2.7%) 178(2.7%) ??? ...cts/racket/contract/private/list.rkt:187:10 --------------------------------------------------------------------- for-loop [36] 50.0% one-iter [31] 50.0% [36] 148(2.3%) 0(0.0%) for-loop ...x-support/src/core/simplify.rkt:116:12 for-loop [36] 50.0% match-e [39] 50.0% --------------------------------------------------------------------- bfadd [33] 32.1% real->bigfloat [29] 67.9% [37] 1354(20.8%) 1354(20.8%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 --------------------------------------------------------------------- loop [34] 100.0% [38] 462(7.1%) 0(0.0%) apply-match ...support/src/core/simplify.rkt:123:2 match-e [39] 35.1% for-loop [40] 32.5% substitute-e [41] 32.5% --------------------------------------------------------------------- apply-match [38] 17.4% for-loop [36] 23.9% for-loop [4] 58.7% [39] 310(4.8%) 162(2.5%) match-e ...omplex-support/src/core/ematch.rkt:46:0 for-loop [2] 82.6% --------------------------------------------------------------------- apply-match [38] 100.0% [40] 150(2.3%) 0(0.0%) for-loop ...x-support/src/core/simplify.rkt:137:10 substitute-e [41] 100.0% --------------------------------------------------------------------- substitute-e [41] 25.0% apply-match [38] 25.0% for-loop [40] 50.0% [41] 300(4.6%) 150(2.3%) substitute-e ...x-support/src/core/ematch.rkt:71:0 mk-enode! [42] 50.0% substitute-e [41] 25.0% --------------------------------------------------------------------- substitute-e [41] 100.0% [42] 150(2.3%) 0(0.0%) mk-enode! ...lex-support/src/core/egraph.rkt:101:0 new-enode [43] 100.0% --------------------------------------------------------------------- mk-enode! [42] 100.0% [43] 150(2.3%) 0(0.0%) new-enode ...mplex-support/src/core/enode.rkt:97:0 type-of-enode-expr [44] 100.0% --------------------------------------------------------------------- new-enode [43] 100.0% [44] 150(2.3%) 0(0.0%) type-of-enode-expr ...port/src/core/enode.rkt:68:0 get-sigs [45] 100.0% --------------------------------------------------------------------- type-of-enode-expr [44] 100.0% [45] 150(2.3%) 0(0.0%) get-sigs ...complex-support/src/type-check.rkt:5:0 ??? [46] 100.0% --------------------------------------------------------------------- get-sigs [45] 49.7% choose-best-alt! [20] 50.3% [46] 302(4.6%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:357:18 ??? [47] 50.3% hash-has-key? [48] 49.7% --------------------------------------------------------------------- ??? [46] 100.0% [47] 152(2.3%) 0(0.0%) ??? ...complex-support/src/core/alt-table.rkt:54:0 ??? [49] 100.0% --------------------------------------------------------------------- ??? [46] 100.0% [48] 150(2.3%) 0(0.0%) hash-has-key? ...et/private/more-scheme.rkt:368:13 ??? [50] 100.0% --------------------------------------------------------------------- ??? [47] 45.8% eval-prog [18] 54.2% [49] 332(5.1%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ??? [51] 54.2% best-alt [52] 45.8% --------------------------------------------------------------------- hash-has-key? [48] 100.0% [50] 150(2.3%) 150(2.3%) ??? ...ects/racket/contract/private/list.rkt:737:4 --------------------------------------------------------------------- ??? [49] 100.0% [51] 180(2.8%) 180(2.8%) ??? ...tract/private/arrow-higher-order.rkt:336:46 --------------------------------------------------------------------- ??? [49] 100.0% [52] 152(2.3%) 0(0.0%) best-alt ...rbie/complex-support/src/glue.rkt:83:0 argmins [53] 100.0% --------------------------------------------------------------------- best-alt [52] 100.0% [53] 152(2.3%) 0(0.0%) argmins ...ie/complex-support/src/common.rkt:138:0 composed [54] 100.0% --------------------------------------------------------------------- argmins [53] 100.0% [54] 152(2.3%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 errors [55] 100.0% --------------------------------------------------------------------- composed [54] 100.0% [55] 152(2.3%) 0(0.0%) errors ...bie/complex-support/src/points.rkt:184:0 for-loop [56] 100.0% --------------------------------------------------------------------- errors [55] 100.0% [56] 152(2.3%) 152(2.3%) for-loop ...e/complex-support/src/points.rkt:187:4 ---------------------------------------------------------------------