Profiling results ----------------- Total cpu time observed: 7876ms (out of 8108ms) Number of samples taken: 42 (once every 188ms) ======================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================== run [5] 50.0% [1] 7876(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 50.0% loop [6] 44.8% run-improve50 [4] 5.2% ------------------------------------------------------------------------ loop [21] 100.0% [2] 156(2.0%) 0(0.0%) ??? ...ket/collects/racket/private/list.rkt:323:18 hash-ref! [19] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [3] 7876(100.0%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [4] 816(10.4%) 0(0.0%) run-improve50 ...ex-support/src/mainloop.rkt:235:0 setup-alt-simplified [7] 38.0% loop [6] 22.5% get-final-combination [8] 20.3% for-loop [9] 19.1% ------------------------------------------------------------------------ profile-thunk16 [3] 100.0% [5] 7876(100.0%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------ run-improve50 [4] 2.5% ??? [1] 97.5% [6] 7244(92.0%) 160(2.0%) loop ...erbie/complex-support/src/points.rkt:159:2 loop [14] 35.3% loop [10] 34.9% make-exacts* [15] 27.5% ------------------------------------------------------------------------ run-improve50 [4] 100.0% [7] 310(3.9%) 0(0.0%) setup-alt-simplified ...-support/src/glue.rkt:55:0 simplify-alt [11] 100.0% ------------------------------------------------------------------------ run-improve50 [4] 100.0% [8] 166(2.1%) 0(0.0%) get-final-combination ...rt/src/mainloop.rkt:265:0 extract-alt [12] 100.0% ------------------------------------------------------------------------ run-improve50 [4] 100.0% [9] 156(2.0%) 0(0.0%) for-loop ...omplex-support/src/mainloop.rkt:250:10 run-iter! [13] 100.0% ------------------------------------------------------------------------ loop [6] 100.0% [10] 2530(32.1%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:119:2 loop [14] 79.4% make-exacts* [15] 13.4% eval-prog [16] 7.3% ------------------------------------------------------------------------ setup-alt-simplified [7] 100.0% [11] 310(3.9%) 0(0.0%) simplify-alt .../complex-support/src/glue.rkt:88:0 simplify [23] 100.0% ------------------------------------------------------------------------ get-final-combination [8] 100.0% [12] 166(2.1%) 0(0.0%) extract-alt ...e/complex-support/src/glue.rkt:61:0 loop [21] 100.0% ------------------------------------------------------------------------ for-loop [9] 100.0% [13] 156(2.0%) 0(0.0%) run-iter! ...omplex-support/src/mainloop.rkt:216:0 localize-error [17] 100.0% ------------------------------------------------------------------------ loop [10] 44.0% loop [6] 56.0% [14] 4568(58.0%) 0(0.0%) loop ...erbie/complex-support/src/points.rkt:109:4 map [18] 57.0% loop [21] 43.0% ------------------------------------------------------------------------ loop [10] 14.5% loop [6] 85.5% [15] 2332(29.6%) 0(0.0%) make-exacts* ...mplex-support/src/points.rkt:106:0 loop [21] 55.1% map [18] 44.9% ------------------------------------------------------------------------ loop [10] 100.0% [16] 184(2.3%) 0(0.0%) eval-prog ...omplex-support/src/programs.rkt:145:0 ??? [24] 100.0% ------------------------------------------------------------------------ run-iter! [13] 100.0% [17] 156(2.0%) 0(0.0%) localize-error ...pport/src/core/localize.rkt:47:0 hash-ref! [19] 100.0% ------------------------------------------------------------------------ make-exacts* [15] 28.7% loop [14] 71.3% [18] 3648(46.3%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 loop [21] 100.0% ------------------------------------------------------------------------ localize-error [17] 33.3% ??? [2] 66.7% [19] 156(2.0%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 parse-loop12 [20] 100.0% ------------------------------------------------------------------------ hash-ref! [19] 100.0% [20] 156(2.0%) 0(0.0%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 loop [21] 100.0% ------------------------------------------------------------------------ loop [14] 0.0% make-exacts* [15] 0.1% parse-loop12 [20] 0.1% map [18] 0.5% extract-alt [12] 2.3% loop [21] 97.0% [21] 7222(91.7%) 476(6.0%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [21] 97.0% simplify [23] 2.3% ??? [22] 0.6% ??? [2] 0.1% ??? [24] 0.0% ------------------------------------------------------------------------ loop [21] 100.0% [22] 6368(80.9%) 146(1.9%) ??? ...rbie/complex-support/src/programs.rkt:151:4 ??? [25] 56.4% ??? [26] 41.3% ------------------------------------------------------------------------ loop [21] 34.9% simplify-alt [11] 65.1% [23] 476(6.0%) 0(0.0%) simplify ...lex-support/src/core/simplify.rkt:39:0 iterate-egraph!5 [27] 100.0% ------------------------------------------------------------------------ eval-prog [16] 46.5% loop [21] 53.5% [24] 396(5.0%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ->flonum [28] 53.5% ??? [29] 46.5% ------------------------------------------------------------------------ ??? [22] 100.0% [25] 3592(45.6%) 874(11.1%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [31] 58.9% ...higher-order.rkt:346:33 [32] 13.3% ??? [35] 3.5% ------------------------------------------------------------------------ ??? [22] 100.0% [26] 2630(33.4%) 110(1.4%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [30] 95.8% ------------------------------------------------------------------------ simplify [23] 100.0% [27] 476(6.0%) 0(0.0%) iterate-egraph!5 ...ort/src/core/simplify.rkt:95:0 one-iter [33] 100.0% ------------------------------------------------------------------------ ??? [24] 100.0% [28] 212(2.7%) 0(0.0%) ->flonum ...s/racket/private/norm-define.rkt:53:83 ??? [34] 100.0% ------------------------------------------------------------------------ ??? [24] 100.0% [29] 184(2.3%) 184(2.3%) ??? ...tract/private/arrow-higher-order.rkt:336:46 ------------------------------------------------------------------------ ??? [26] 100.0% [30] 2520(32.0%) 1490(18.9%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [40] 40.9% ------------------------------------------------------------------------ ??? [25] 100.0% [31] 2116(26.9%) 306(3.9%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfsub [36] 85.5% ------------------------------------------------------------------------ ??? [25] 100.0% [32] 476(6.0%) 0(0.0%) ...higher-order.rkt:346:33 (unknown source) ??? [37] 100.0% ------------------------------------------------------------------------ iterate-egraph!5 [27] 100.0% [33] 476(6.0%) 0(0.0%) one-iter ...ex-support/src/core/simplify.rkt:106:0 loop [38] 100.0% ------------------------------------------------------------------------ ->flonum [28] 100.0% [34] 212(2.7%) 0(0.0%) ??? .../herbie/complex-support/src/config.rkt:48:0 ??? [39] 100.0% ------------------------------------------------------------------------ ??? [25] 100.0% [35] 126(1.6%) 126(1.6%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 ------------------------------------------------------------------------ ??? [31] 100.0% [36] 1810(23.0%) 1342(17.0%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [40] 25.9% ------------------------------------------------------------------------ ...higher-order.rkt:346:33 [32] 100.0% [37] 476(6.0%) 476(6.0%) ??? ...cts/racket/contract/private/list.rkt:187:10 ------------------------------------------------------------------------ one-iter [33] 100.0% [38] 476(6.0%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:52:19 apply-match [41] 100.0% ------------------------------------------------------------------------ ??? [34] 100.0% [39] 212(2.7%) 0(0.0%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [42] 100.0% ------------------------------------------------------------------------ bfsub [36] 31.2% real->bigfloat [30] 68.8% [40] 1498(19.0%) 1498(19.0%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ------------------------------------------------------------------------ loop [38] 100.0% [41] 476(6.0%) 0(0.0%) apply-match ...support/src/core/simplify.rkt:123:2 mk-enode! [43] 69.3% for-loop [44] 30.7% ------------------------------------------------------------------------ ??? [39] 100.0% [42] 212(2.7%) 212(2.7%) ??? ...ects/racket/contract/private/guts.rkt:644:8 ------------------------------------------------------------------------ apply-match [41] 100.0% [43] 330(4.2%) 0(0.0%) mk-enode! ...lex-support/src/core/egraph.rkt:101:0 new-enode [45] 100.0% ------------------------------------------------------------------------ apply-match [41] 100.0% [44] 146(1.9%) 0(0.0%) for-loop ...x-support/src/core/simplify.rkt:137:10 substitute-e [46] 100.0% ------------------------------------------------------------------------ mk-enode! [43] 100.0% [45] 330(4.2%) 0(0.0%) new-enode ...mplex-support/src/core/enode.rkt:97:0 type-of-enode-expr [47] 100.0% ------------------------------------------------------------------------ for-loop [44] 33.3% substitute-e [46] 66.7% [46] 146(1.9%) 146(1.9%) substitute-e ...x-support/src/core/ematch.rkt:71:0 substitute-e [46] 66.7% ------------------------------------------------------------------------ new-enode [45] 100.0% [47] 330(4.2%) 0(0.0%) type-of-enode-expr ...port/src/core/enode.rkt:68:0 get-sigs [48] 100.0% ------------------------------------------------------------------------ type-of-enode-expr [47] 100.0% [48] 330(4.2%) 0(0.0%) get-sigs ...complex-support/src/type-check.rkt:5:0 ??? [49] 50.3% ??? [50] 49.7% ------------------------------------------------------------------------ get-sigs [48] 100.0% [49] 166(2.1%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:357:18 hash-has-key? [51] 100.0% ------------------------------------------------------------------------ get-sigs [48] 100.0% [50] 164(2.1%) 0(0.0%) ??? ...ts/racket/contract/private/arr-i.rkt:804:10 get/build-late-neg-projection [52]100.0% ------------------------------------------------------------------------ ??? [49] 100.0% [51] 166(2.1%) 166(2.1%) hash-has-key? ...et/private/more-scheme.rkt:368:13 ------------------------------------------------------------------------ ??? [53] 50.0% ??? [50] 50.0% [52] 164(2.1%) 164(2.1%) get/build-late-neg-projection ...te/guts.rkt:691:0 ??? [53] 50.0% ------------------------------------------------------------------------ get/build-late-neg-projection [52]100.0% [53] 164(2.1%) 0(0.0%) ??? ...ects/racket/contract/private/hash.rkt:211:2 get/build-late-neg-projection [52]100.0% ------------------------------------------------------------------------