Profiling results ----------------- Total cpu time observed: 123176ms (out of 125064ms) Number of samples taken: 329 (once every 374ms) (Hiding functions with self<1.0% and local<2.0%: 3 of 89 hidden) ======================================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================================== ??? [6] 100.0% [1] 122136(99.2%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [4] 100.0% ---------------------------------------------------------------------------------------- ??? [7] 100.0% [2] 304(0.2%) 0(0.0%) approximate9 ...e/develop/src/core/taylor.rkt:12:0 loop [5] 100.0% ---------------------------------------------------------------------------------------- f6 [45] 100.0% [3] 304(0.2%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 parse-loop12 [41] 100.0% ---------------------------------------------------------------------------------------- profile-thunk16 [1] 99.7% [4] 122446(99.4%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [6] 100.0% ---------------------------------------------------------------------------------------- approximate9 [2] 100.0% [5] 304(0.2%) 0(0.0%) loop ...es/herbie/develop/src/core/taylor.rkt:86:4 ??? [7] 100.0% ---------------------------------------------------------------------------------------- for-loop [35] 0.3% run [4] 49.9% [6] 122744(99.6%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 49.6% loop [10] 35.6% prepare-points [11] 11.0% run-improve50 [8] 3.3% ->flonum [9] 0.5% ---------------------------------------------------------------------------------------- loop [5] 2.9% ->flonum [9] 2.9% for-loop [47] 2.9% ??? [33] 11.7% loop [52] 79.5% [7] 3446(2.8%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ->flonum [9] 94.1% approximate9 [2] 2.9% hash-ref! [38] 2.9% ---------------------------------------------------------------------------------------- ??? [6] 100.0% [8] 8102(6.6%) 0(0.0%) run-improve50 ...ie/develop/src/mainloop.rkt:234:0 loop [10] 55.8% for-loop [12] 36.1% prepare-points [11] 8.1% ---------------------------------------------------------------------------------------- for-loop [15] 6.3% ->flonum [9] 7.0% ??? [6] 13.4% ??? [7] 73.3% [9] 4704(3.8%) 2094(1.7%) ->flonum ...s/racket/private/norm-define.rkt:53:83 for-loop [16] 8.5% ->flonum [9] 7.0% ??? [17] 7.0% mk-egraph [13] 6.8% return/no-unsupplied [18] 6.8% iterate-egraph!13 [14] 6.5% ??? [7] 6.5% for-loop [15] 6.3% ---------------------------------------------------------------------------------------- run-improve50 [8] 4.9% ??? [6] 95.1% [10] 91904(74.6%) 310(0.3%) loop ...htlies/herbie/develop/src/points.rkt:238:2 loop [19] 37.4% loop [26] 32.1% make-exacts* [27] 29.7% for-loop [22] 0.4% ---------------------------------------------------------------------------------------- run-improve50 [8] 2.4% ??? [6] 97.6% [11] 27616(22.4%) 0(0.0%) prepare-points ...bie/develop/src/points.rkt:214:0 loop [26] 40.3% make-exacts* [27] 32.7% loop [19] 27.0% ---------------------------------------------------------------------------------------- run-improve50 [8] 100.0% [12] 2926(2.4%) 0(0.0%) for-loop ...herbie/develop/src/mainloop.rkt:249:10 run-iter! [20] 100.0% ---------------------------------------------------------------------------------------- ->flonum [9] 100.0% [13] 644(0.5%) 0(0.0%) mk-egraph ...bie/develop/src/core/egraph.rkt:131:0 mk-enode-rec! [23] 53.7% mk-enode! [30] 46.3% ---------------------------------------------------------------------------------------- ->flonum [9] 100.0% [14] 614(0.5%) 0(0.0%) iterate-egraph!13 ...p/src/core/simplify.rkt:105:0 one-iter [21] 100.0% ---------------------------------------------------------------------------------------- ->flonum [9] 100.0% [15] 596(0.5%) 0(0.0%) for-loop ...ie/develop/src/core/simplify.rkt:66:12 ->flonum [9] 100.0% ---------------------------------------------------------------------------------------- ->flonum [9] 100.0% [16] 402(0.3%) 402(0.3%) for-loop ...ies/herbie/develop/src/points.rkt:47:4 ---------------------------------------------------------------------------------------- ->flonum [9] 100.0% [17] 328(0.3%) 0(0.0%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [24] 100.0% ---------------------------------------------------------------------------------------- ->flonum [9] 100.0% [18] 318(0.3%) 0(0.0%) return/no-unsupplied ...ct/private/arr-i.rkt:533:0 filter [25] 100.0% ---------------------------------------------------------------------------------------- prepare-points [11] 17.8% loop [10] 82.2% [19] 41872(34.0%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:158:2 make-exacts* [27] 51.5% loop [26] 48.5% ---------------------------------------------------------------------------------------- for-loop [12] 100.0% [20] 2926(2.4%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:215:0 finalize-iter! [28] 36.3% simplify! [29] 32.8% gen-series! [32] 20.6% localize-error [34] 10.3% ---------------------------------------------------------------------------------------- iterate-egraph!13 [14] 100.0% [21] 614(0.5%) 0(0.0%) one-iter ...ie/develop/src/core/simplify.rkt:116:0 for-loop [31] 100.0% ---------------------------------------------------------------------------------------- loop [10] 100.0% [22] 402(0.3%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:255:26 ??? [33] 100.0% ---------------------------------------------------------------------------------------- mk-enode-rec! [23] 50.0% mk-egraph [13] 50.0% [23] 346(0.3%) 0(0.0%) mk-enode-rec! ...develop/src/core/egraph.rkt:122:0 mk-enode-rec! [23] 50.0% mk-enode! [30] 50.0% ---------------------------------------------------------------------------------------- ??? [17] 100.0% [24] 328(0.3%) 328(0.3%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 ---------------------------------------------------------------------------------------- return/no-unsupplied [18] 100.0% [25] 318(0.3%) 318(0.3%) filter ...t/collects/racket/private/list.rkt:256:2 ---------------------------------------------------------------------------------------- prepare-points [11] 18.3% loop [19] 33.3% loop [10] 48.4% [26] 60890(49.4%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:141:4 loop [52] 100.0% ---------------------------------------------------------------------------------------- prepare-points [11] 15.6% loop [19] 37.3% loop [10] 47.2% [27] 57918(47.0%) 0(0.0%) make-exacts* ...erbie/develop/src/points.rkt:138:0 loop [52] 99.4% ---------------------------------------------------------------------------------------- run-iter! [20] 100.0% [28] 1062(0.9%) 0(0.0%) finalize-iter! ...e/develop/src/mainloop.rkt:169:0 ??? [48] 100.0% ---------------------------------------------------------------------------------------- run-iter! [20] 100.0% [29] 960(0.8%) 0(0.0%) simplify! ...herbie/develop/src/mainloop.rkt:155:0 for-loop [35] 100.0% ---------------------------------------------------------------------------------------- mk-egraph [13] 46.3% mk-enode-rec! [23] 53.7% [30] 644(0.5%) 0(0.0%) mk-enode! ...bie/develop/src/core/egraph.rkt:102:0 new-enode [36] 100.0% ---------------------------------------------------------------------------------------- for-loop [31] 50.0% one-iter [21] 50.0% [31] 614(0.5%) 0(0.0%) for-loop ...e/develop/src/core/simplify.rkt:126:12 for-loop [31] 50.0% match-e [37] 50.0% ---------------------------------------------------------------------------------------- run-iter! [20] 100.0% [32] 604(0.5%) 0(0.0%) gen-series! ...rbie/develop/src/mainloop.rkt:129:0 for-loop [39] 100.0% ---------------------------------------------------------------------------------------- for-loop [22] 100.0% [33] 402(0.3%) 0(0.0%) ??? ...ghtlies/herbie/develop/src/points.rkt:230:7 ??? [7] 100.0% ---------------------------------------------------------------------------------------- run-iter! [20] 100.0% [34] 300(0.2%) 0(0.0%) localize-error ...velop/src/core/localize.rkt:47:0 hash-ref! [38] 100.0% ---------------------------------------------------------------------------------------- simplify! [29] 100.0% [35] 960(0.8%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:159:6 ??? [6] 100.0% ---------------------------------------------------------------------------------------- mk-enode! [30] 100.0% [36] 644(0.5%) 0(0.0%) new-enode ...erbie/develop/src/core/enode.rkt:97:0 type-of-enode-expr [40] 100.0% ---------------------------------------------------------------------------------------- for-loop [31] 100.0% [37] 614(0.5%) 298(0.2%) match-e ...herbie/develop/src/core/ematch.rkt:46:0 ??? [48] 51.5% ---------------------------------------------------------------------------------------- localize-error [34] 12.4% ??? [43] 25.2% ??? [7] 25.2% ??? [60] 37.3% [38] 604(0.5%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 ??? [43] 25.2% simplify [44] 25.2% parse-loop12 [41] 24.8% f6 [45] 24.8% ---------------------------------------------------------------------------------------- gen-series! [32] 100.0% [39] 604(0.5%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:135:7 taylor-alt [42] 100.0% ---------------------------------------------------------------------------------------- new-enode [36] 100.0% [40] 644(0.5%) 0(0.0%) type-of-enode-expr ...elop/src/core/enode.rkt:68:0 get-sigs [46] 100.0% ---------------------------------------------------------------------------------------- hash-ref! [38] 49.7% composed [3] 50.3% [41] 604(0.5%) 0(0.0%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 append-map [51] 50.3% loop [52] 49.7% ---------------------------------------------------------------------------------------- for-loop [39] 100.0% [42] 604(0.5%) 0(0.0%) taylor-alt ...es/herbie/develop/src/glue.rkt:134:0 for-loop [47] 50.3% f6 [45] 49.7% ---------------------------------------------------------------------------------------- hash-ref! [38] 100.0% [43] 304(0.2%) 0(0.0%) ??? ...es/herbie/develop/src/core/taylor.rkt:44:15 hash-ref! [38] 100.0% ---------------------------------------------------------------------------------------- hash-ref! [38] 100.0% [44] 304(0.2%) 0(0.0%) simplify ...erbie/develop/src/core/reduce.rkt:16:0 f6 [45] 100.0% ---------------------------------------------------------------------------------------- map [49] 6.7% simplify [44] 6.7% append-map [51] 20.2% hash-ref! [38] 33.2% taylor-alt [42] 33.2% [45] 904(0.7%) 0(0.0%) f6 ...et/collects/racket/match/compiler.rkt:507:40 map [49] 39.9% ??? [50] 33.2% append-map [51] 20.2% composed [3] 6.7% ---------------------------------------------------------------------------------------- type-of-enode-expr [40] 100.0% [46] 644(0.5%) 0(0.0%) get-sigs .../herbie/develop/src/type-check.rkt:5:0 ??? [48] 53.7% ??? [50] 46.3% ---------------------------------------------------------------------------------------- taylor-alt [42] 100.0% [47] 304(0.2%) 0(0.0%) for-loop ...lies/herbie/develop/src/glue.rkt:139:6 ??? [7] 100.0% ---------------------------------------------------------------------------------------- match-e [37] 18.3% get-sigs [46] 20.1% finalize-iter! [28] 61.6% [48] 1724(1.4%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:357:18 for-loop [53] 61.6% hash-has-key? [54] 38.4% ---------------------------------------------------------------------------------------- f6 [45] 100.0% [49] 604(0.5%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 f6 [45] 50.3% ??? [60] 24.8% loop [52] 24.8% ---------------------------------------------------------------------------------------- get-sigs [46] 49.8% f6 [45] 50.2% [50] 598(0.5%) 0(0.0%) ??? ...ts/racket/contract/private/arr-i.rkt:804:10 for-loop [56] 50.2% ??? [57] 49.8% ---------------------------------------------------------------------------------------- parse-loop12 [41] 25.0% f6 [45] 75.0% [51] 304(0.2%) 0(0.0%) append-map ...acket/collects/racket/list.rkt:565:2 f6 [45] 75.0% free-variables [55] 25.0% ---------------------------------------------------------------------------------------- map [49] 0.0% parse-loop12 [41] 0.0% loop [26] 2.6% make-exacts* [27] 2.7% loop [52] 94.6% [52] 119202(96.8%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [52] 94.6% ??? [72] 5.3% ??? [7] 0.0% ??? [60] 0.0% ??? [80] 0.0% ---------------------------------------------------------------------------------------- ??? [48] 100.0% [53] 1062(0.9%) 0(0.0%) for-loop ...ie/develop/src/core/alt-table.rkt:51:2 atab-add-altn [58] 100.0% ---------------------------------------------------------------------------------------- ??? [48] 100.0% [54] 662(0.5%) 0(0.0%) hash-has-key? ...et/private/more-scheme.rkt:368:13 ??? [59] 100.0% ---------------------------------------------------------------------------------------- append-map [51] 100.0% [55] 304(0.2%) 304(0.2%) free-variables ...e/develop/src/programs.rkt:102:0 ---------------------------------------------------------------------------------------- ??? [50] 100.0% [56] 300(0.2%) 0(0.0%) for-loop ...racket/contract/private/hash.rkt:239:6 ??? [79] 100.0% ---------------------------------------------------------------------------------------- ??? [50] 100.0% [57] 298(0.2%) 0(0.0%) ??? ...ects/racket/contract/private/hash.rkt:217:4 ??? [61] 100.0% ---------------------------------------------------------------------------------------- for-loop [53] 100.0% [58] 1062(0.9%) 0(0.0%) atab-add-altn ...elop/src/core/alt-table.rkt:208:0 best-and-tied-at-points [62] 100.0% ---------------------------------------------------------------------------------------- hash-has-key? [54] 100.0% [59] 662(0.5%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:737:4 for-loop [63] 52.3% successfully-got-the-right-kind-of-function [64] 47.7% ---------------------------------------------------------------------------------------- map [49] 33.3% loop [52] 66.7% [60] 300(0.2%) 0(0.0%) ??? ...ket/collects/racket/private/list.rkt:323:18 hash-ref! [38] 100.0% ---------------------------------------------------------------------------------------- ??? [57] 100.0% [61] 298(0.2%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:169:2 ??? [65] 100.0% ---------------------------------------------------------------------------------------- atab-add-altn [58] 100.0% [62] 1062(0.9%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:122:0 errors [66] 100.0% ---------------------------------------------------------------------------------------- ??? [59] 100.0% [63] 346(0.3%) 346(0.3%) for-loop ...acket/contract/private/list.rkt:743:12 ---------------------------------------------------------------------------------------- ??? [59] 100.0% [64] 316(0.3%) 0(0.0%) successfully-got-the-right-kind-of-function ...9:4 arity-checking-wrapper [67] 100.0% ---------------------------------------------------------------------------------------- ??? [61] 100.0% [65] 298(0.2%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:678:5 for-loop [68] 100.0% ---------------------------------------------------------------------------------------- best-and-tied-at-points [62] 100.0% [66] 1062(0.9%) 0(0.0%) errors ...lies/herbie/develop/src/points.rkt:271:0 for-loop [69] 100.0% ---------------------------------------------------------------------------------------- successfully-got-the-right-kind-of-function [64]100.0% [67] 316(0.3%) 0(0.0%) arity-checking-wrapper ...w-higher-order.rkt:402:0 matches-arity-exactly? [70] 100.0% ---------------------------------------------------------------------------------------- ??? [65] 100.0% [68] 298(0.2%) 0(0.0%) for-loop ...racket/contract/private/list.rkt:680:9 add-list-context [71] 100.0% ---------------------------------------------------------------------------------------- errors [66] 100.0% [69] 1062(0.9%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:274:4 ??? [72] 100.0% ---------------------------------------------------------------------------------------- arity-checking-wrapper [67] 100.0% [70] 316(0.3%) 316(0.3%) matches-arity-exactly? ...te/arrow-common.rkt:70:0 ---------------------------------------------------------------------------------------- for-loop [68] 100.0% [71] 298(0.2%) 298(0.2%) add-list-context ...ontract/private/list.rkt:752:0 ---------------------------------------------------------------------------------------- for-loop [69] 0.9% loop [52] 99.1% [72] 117224(95.2%) 2322(1.9%) ??? ...tlies/herbie/develop/src/programs.rkt:156:4 ??? [73] 90.2% ??? [74] 7.8% ---------------------------------------------------------------------------------------- ??? [72] 100.0% [73] 105718(85.8%) 7684(6.2%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [80] 76.0% bffmod [75] 10.9% bf* [78] 4.4% ...higher-order.rkt:346:33 [77] 0.7% ---------------------------------------------------------------------------------------- ??? [72] 100.0% [74] 9184(7.5%) 0(0.0%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [76] 100.0% ---------------------------------------------------------------------------------------- ??? [73] 100.0% [75] 11542(9.4%) 364(0.3%) bffmod ...rbie/develop/src/syntax/syntax.rkt:332:0 ??? [80] 74.8% bf* [78] 22.1% ---------------------------------------------------------------------------------------- ??? [74] 100.0% [76] 9184(7.5%) 7876(6.4%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [86] 14.2% ---------------------------------------------------------------------------------------- ??? [73] 100.0% [77] 700(0.6%) 358(0.3%) ...higher-order.rkt:346:33 (unknown source) ??? [79] 48.9% ---------------------------------------------------------------------------------------- bffmod [75] 35.2% ??? [73] 64.8% [78] 7246(5.9%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [80] 100.0% ---------------------------------------------------------------------------------------- for-loop [56] 46.7% ...higher-order.rkt:346:33 [77] 53.3% [79] 642(0.5%) 0(0.0%) ??? ...cts/racket/contract/private/list.rkt:187:10 ??? [85] 53.3% ??? [81] 46.7% ---------------------------------------------------------------------------------------- loop [52] 0.3% bf* [78] 7.5% bffmod [75] 8.9% ??? [73] 83.2% [80] 96568(78.4%) 72186(58.6%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfdiv [82] 18.7% bfasin [83] 5.4% bffloor [84] 1.2% ---------------------------------------------------------------------------------------- ??? [79] 100.0% [81] 300(0.2%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:686:7 ??? [85] 100.0% ---------------------------------------------------------------------------------------- ??? [80] 100.0% [82] 18054(14.7%) 15966(13.0%) bfdiv ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [86] 11.6% ---------------------------------------------------------------------------------------- ??? [80] 100.0% [83] 5208(4.2%) 4222(3.4%) bfasin ...lib/math/private/bigfloat/mpfr.rkt:616:4 ??? [86] 18.9% ---------------------------------------------------------------------------------------- ??? [80] 100.0% [84] 1120(0.9%) 426(0.3%) bffloor ...ib/math/private/bigfloat/mpfr.rkt:714:4 ??? [86] 62.0% ---------------------------------------------------------------------------------------- ??? [81] 46.7% ??? [79] 53.3% [85] 642(0.5%) 642(0.5%) ??? ...ects/racket/contract/private/guts.rkt:644:8 ---------------------------------------------------------------------------------------- bffloor [84] 13.7% bfasin [83] 19.4% real->bigfloat [76] 25.8% bfdiv [82] 41.1% [86] 5076(4.1%) 5076(4.1%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ----------------------------------------------------------------------------------------