Profiling results ----------------- Total cpu time observed: 4980ms (out of 5344ms) Number of samples taken: 25 (once every 199ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== [1] 4980(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [8] 100.0% ---------------------------------------------------------------------- ??? [66] 100.0% [2] 636(12.8%) 0(0.0%) approximate9 ...ie/master/src/core/taylor.rkt:12:0 loop [9] 68.6% for-loop [13] 31.4% ---------------------------------------------------------------------- hash-ref! [15] 100.0% [3] 436(8.8%) 0(0.0%) ??? ...ies/herbie/master/src/core/taylor.rkt:45:15 hash-ref! [15] 53.2% ??? [12] 46.8% ---------------------------------------------------------------------- hash-ref! [15] 100.0% [4] 232(4.7%) 0(0.0%) ??? ...ies/herbie/master/src/core/taylor.rkt:68:15 ??? [66] 100.0% ---------------------------------------------------------------------- hash-ref! [15] 100.0% [5] 232(4.7%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:291:26 for-loop [11] 100.0% ---------------------------------------------------------------------- hash-ref! [15] 100.0% [6] 232(4.7%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:301:23 for-loop [10] 100.0% ---------------------------------------------------------------------- map [37] 100.0% [7] 200(4.0%) 0(0.0%) simplify* ...erbie/master/src/core/reduce.rkt:31:0 hash-ref! [15] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [8] 4980(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [14] 100.0% ---------------------------------------------------------------------- approximate9 [2] 100.0% [9] 436(8.8%) 0(0.0%) loop ...ies/herbie/master/src/core/taylor.rkt:87:4 hash-ref! [15] 53.2% ??? [66] 46.8% ---------------------------------------------------------------------- ??? [6] 100.0% [10] 232(4.7%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:304:27 hash-ref! [15] 100.0% ---------------------------------------------------------------------- ??? [5] 100.0% [11] 232(4.7%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:291:52 hash-ref! [15] 100.0% ---------------------------------------------------------------------- ??? [3] 100.0% [12] 204(4.1%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:294:19 hash-ref! [15] 100.0% ---------------------------------------------------------------------- approximate9 [2] 100.0% [13] 200(4.0%) 0(0.0%) for-loop ...erbie/master/src/core/taylor.rkt:30:18 taylor [16] 100.0% ---------------------------------------------------------------------- profile-thunk16 [8] 100.0% [14] 4980(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [17] 100.0% ---------------------------------------------------------------------- for-loop [11] 6.1% ??? [18] 6.1% for-loop [10] 6.1% ??? [3] 6.1% loop [9] 6.1% ??? [12] 16.0% ??? [66] 22.1% simplify* [7] 31.4% [15] 636(12.8%) 200(4.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [3] 22.1% simplify [22] 22.1% ??? [4] 6.1% ??? [6] 6.1% ??? [18] 6.1% ??? [5] 6.1% ---------------------------------------------------------------------- for-loop [13] 100.0% [16] 200(4.0%) 0(0.0%) taylor .../herbie/master/src/core/taylor.rkt:170:0 taylor-quotient [19] 100.0% ---------------------------------------------------------------------- for-loop [73] 7.9% run [14] 92.1% [17] 4980(100.0%) 192(3.9%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [21] 42.5% run-improve47 [20] 37.4% oracle-error [24] 4.2% get-final-combination [25] 4.0% eval-errors [26] 4.0% ??? [40] 3.9% *bit-width* [23] 2.1% ---------------------------------------------------------------------- hash-ref! [15] 100.0% [18] 232(4.7%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:344:33 hash-ref! [15] 100.0% ---------------------------------------------------------------------- taylor [16] 100.0% [19] 200(4.0%) 0(0.0%) taylor-quotient ...aster/src/core/taylor.rkt:334:0 simplify [22] 100.0% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [20] 2258(45.3%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:346:0 for-loop [28] 91.5% simplify! [43] 8.5% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [21] 2116(42.5%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:110:0 loop [27] 100.0% ---------------------------------------------------------------------- taylor-quotient [19] 31.4% hash-ref! [15] 68.6% [22] 636(12.8%) 0(0.0%) simplify ...herbie/master/src/core/reduce.rkt:16:0 parse-loop80 [29] 68.6% f46 [31] 31.4% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [23] 208(4.2%) 208(4.2%) *bit-width* ...es/herbie/master/src/float.rkt:35:0 ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [24] 208(4.2%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:188:0 for-loop [30] 100.0% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [25] 200(4.0%) 0(0.0%) get-final-combination ...er/src/mainloop.rkt:371:0 infer-splitpoints [32] 100.0% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [26] 198(4.0%) 0(0.0%) eval-errors .../herbie/master/src/points.rkt:179:0 for-loop [33] 100.0% ---------------------------------------------------------------------- prepare-points-intervals [21] 100.0% [27] 2116(42.5%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:123:4 loop [35] 54.3% ??? [36] 45.7% ---------------------------------------------------------------------- run-improve47 [20] 100.0% [28] 2066(41.5%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:365:4 run-iter! [34] 100.0% ---------------------------------------------------------------------- simplify [22] 100.0% [29] 436(8.8%) 232(4.7%) parse-loop80 (unknown source) eval-const-expr [38] 46.8% ---------------------------------------------------------------------- oracle-error [24] 100.0% [30] 208(4.2%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:189:2 map [37] 100.0% ---------------------------------------------------------------------- simplify [22] 33.3% map [37] 66.7% [31] 200(4.0%) 0(0.0%) f46 (unknown source) map [37] 100.0% ---------------------------------------------------------------------- get-final-combination [25] 100.0% [32] 200(4.0%) 0(0.0%) infer-splitpoints ...ter/src/core/regimes.rkt:34:0 for-loop [39] 100.0% ---------------------------------------------------------------------- eval-errors [26] 100.0% [33] 198(4.0%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:181:2 ??? [40] 100.0% ---------------------------------------------------------------------- for-loop [28] 100.0% [34] 2066(41.5%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:327:0 finalize-iter! [41] 38.5% gen-series! [42] 30.8% simplify! [43] 21.3% choose-best-alt! [45] 9.4% ---------------------------------------------------------------------- loop [27] 100.0% [35] 1150(23.1%) 184(3.7%) loop ...ightlies/herbie/master/src/points.rkt:81:2 ??? [40] 51.0% ??? [46] 33.0% ---------------------------------------------------------------------- loop [27] 100.0% [36] 966(19.4%) 190(3.8%) ??? ...ightlies/herbie/master/src/points.rkt:106:2 ??? [66] 80.3% ---------------------------------------------------------------------- f46 [31] 49.0% for-loop [30] 51.0% [37] 408(8.2%) 208(4.2%) map ...t-7.5/collects/racket/private/map.rkt:35:13 f46 [31] 32.7% simplify* [7] 16.3% ---------------------------------------------------------------------- parse-loop80 [29] 100.0% [38] 204(4.1%) 0(0.0%) eval-const-expr ...e/master/src/programs.rkt:118:0 temp85_0 [76] 100.0% ---------------------------------------------------------------------- infer-splitpoints [32] 100.0% [39] 200(4.0%) 0(0.0%) for-loop ...erbie/master/src/core/regimes.rkt:47:6 option-on-expr [44] 100.0% ---------------------------------------------------------------------- for-loop [33] 16.9% .../more-scheme.rkt:261:28 [17] 33.1% loop [35] 50.0% [40] 1172(23.5%) 392(7.9%) ??? ...htlies/herbie/master/src/programs.rkt:115:2 ??? [49] 32.8% ??? [66] 17.2% ??? [51] 16.6% ---------------------------------------------------------------------- run-iter! [34] 100.0% [41] 796(16.0%) 0(0.0%) finalize-iter! ...ie/master/src/mainloop.rkt:278:0 ??? [46] 100.0% ---------------------------------------------------------------------- run-iter! [34] 100.0% [42] 636(12.8%) 0(0.0%) gen-series! ...erbie/master/src/mainloop.rkt:160:0 for-loop [47] 100.0% ---------------------------------------------------------------------- run-improve47 [20] 30.4% run-iter! [34] 69.6% [43] 632(12.7%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:224:0 egraph-run [48] 100.0% ---------------------------------------------------------------------- for-loop [39] 100.0% [44] 200(4.0%) 0(0.0%) option-on-expr ...aster/src/core/regimes.rkt:126:0 for-loop [50] 100.0% ---------------------------------------------------------------------- run-iter! [34] 100.0% [45] 194(3.9%) 0(0.0%) choose-best-alt! .../master/src/mainloop.rkt:117:0 ...ow-val-first.rkt:486:18 [52] 100.0% ---------------------------------------------------------------------- loop [35] 32.3% finalize-iter! [41] 67.7% [46] 1176(23.6%) 184(3.7%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [53] 67.7% ??? [57] 16.7% ---------------------------------------------------------------------- gen-series! [42] 100.0% [47] 636(12.8%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:167:7 taylor-alt [54] 100.0% ---------------------------------------------------------------------- simplify! [43] 100.0% [48] 632(12.7%) 0(0.0%) egraph-run ...bie/master/src/core/eggmath.rkt:51:0 egraph-add-exprs [55] 100.0% ---------------------------------------------------------------------- ??? [40] 100.0% [49] 384(7.7%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-sub [56] 51.6% ival-div [59] 48.4% ---------------------------------------------------------------------- option-on-expr [44] 100.0% [50] 200(4.0%) 0(0.0%) for-loop ...rbie/master/src/core/regimes.rkt:136:4 errors [69] 100.0% ---------------------------------------------------------------------- ??? [40] 100.0% [51] 194(3.9%) 194(3.9%) ??? .../herbie/master/src/syntax/syntax.rkt:214:17 ---------------------------------------------------------------------- choose-best-alt! [45] 100.0% [52] 194(3.9%) 0(0.0%) ...ow-val-first.rkt:486:18 (unknown source) ??? [58] 100.0% ---------------------------------------------------------------------- ??? [46] 100.0% [53] 796(16.0%) 0(0.0%) for-loop ...bie/master/src/core/alt-table.rkt:55:2 errors [69] 75.6% atab-add-altn [64] 24.4% ---------------------------------------------------------------------- for-loop [47] 100.0% [54] 636(12.8%) 0(0.0%) taylor-alt ...herbie/master/src/mainloop.rkt:146:0 for-loop [60] 100.0% ---------------------------------------------------------------------- egraph-run [48] 100.0% [55] 632(12.7%) 0(0.0%) egraph-add-exprs ...ter/src/core/eggmath.rkt:113:0 ??? [61] 100.0% ---------------------------------------------------------------------- ??? [49] 100.0% [56] 198(4.0%) 0(0.0%) ival-sub ...erbie/master/src/biginterval.rkt:107:0 bfsub [62] 100.0% ---------------------------------------------------------------------- ??? [46] 100.0% [57] 196(3.9%) 0(0.0%) ??? ...ects/racket/contract/private/guts.rkt:770:8 bigvalue? [63] 100.0% ---------------------------------------------------------------------- ...ow-val-first.rkt:486:18 [52] 100.0% [58] 194(3.9%) 0(0.0%) ??? ...s/herbie/master/src/core/alt-table.rkt:58:0 argmin [65] 100.0% ---------------------------------------------------------------------- ??? [49] 100.0% [59] 186(3.7%) 186(3.7%) ival-div ...erbie/master/src/biginterval.rkt:155:0 ---------------------------------------------------------------------- taylor-alt [54] 100.0% [60] 636(12.8%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:152:6 ??? [66] 100.0% ---------------------------------------------------------------------- egraph-add-exprs [55] 100.0% [61] 632(12.7%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:72:6 for-loop [67] 100.0% ---------------------------------------------------------------------- ival-sub [56] 100.0% [62] 198(4.0%) 0(0.0%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [77] 100.0% ---------------------------------------------------------------------- ??? [57] 100.0% [63] 196(3.9%) 196(3.9%) bigvalue? ...rbie/master/src/syntax/types.rkt:19:0 ---------------------------------------------------------------------- for-loop [53] 100.0% [64] 194(3.9%) 0(0.0%) atab-add-altn ...ster/src/core/alt-table.rkt:203:0 errors [69] 100.0% ---------------------------------------------------------------------- ??? [58] 100.0% [65] 194(3.9%) 0(0.0%) argmin ...acket-7.5/collects/racket/list.rkt:765:0 ??? [68] 100.0% ---------------------------------------------------------------------- loop [9] 4.2% ??? [4] 4.8% ??? [40] 12.5% location-do [71] 15.2% for-loop [60] 15.2% ??? [36] 48.1% [66] 1614(32.4%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 sample-multi-bounded [70] 48.1% location-do [71] 15.2% approximate9 [2] 15.2% mk-ival [72] 12.5% hash-ref! [15] 9.0% ---------------------------------------------------------------------- ??? [61] 100.0% [67] 632(12.7%) 632(12.7%) for-loop ...rbie/master/src/core/simplify.rkt:91:2 ---------------------------------------------------------------------- argmin [65] 100.0% [68] 194(3.9%) 0(0.0%) ??? ...tlies/herbie/master/src/mainloop.rkt:114:10 errors [69] 100.0% ---------------------------------------------------------------------- atab-add-altn [64] 16.3% ??? [68] 16.3% for-loop [50] 16.8% for-loop [53] 50.6% [69] 1190(23.9%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:201:0 for-loop [73] 66.2% eval-prog [74] 33.8% ---------------------------------------------------------------------- ??? [66] 100.0% [70] 776(15.6%) 776(15.6%) sample-multi-bounded ...master/src/points.rkt:15:0 ---------------------------------------------------------------------- location-do [71] 18.2% ??? [66] 81.8% [71] 636(12.8%) 0(0.0%) location-do ...herbie/master/src/programs.rkt:64:0 ??? [66] 81.8% location-do [71] 18.2% ---------------------------------------------------------------------- ??? [66] 100.0% [72] 202(4.1%) 0(0.0%) mk-ival .../herbie/master/src/biginterval.rkt:65:0 bf [75] 100.0% ---------------------------------------------------------------------- errors [69] 100.0% [73] 788(15.8%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:203:2 .../more-scheme.rkt:261:28 [17] 100.0% ---------------------------------------------------------------------- errors [69] 100.0% [74] 402(8.1%) 0(0.0%) eval-prog ...s/herbie/master/src/programs.rkt:83:0 temp85_0 [76] 100.0% ---------------------------------------------------------------------- mk-ival [72] 100.0% [75] 202(4.1%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [77] 100.0% ---------------------------------------------------------------------- eval-const-expr [38] 33.7% eval-prog [74] 66.3% [76] 606(12.2%) 0(0.0%) temp85_0 (unknown source) compile15 [78] 100.0% ---------------------------------------------------------------------- bfsub [62] 49.5% bf [75] 50.5% [77] 400(8.0%) 400(8.0%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ---------------------------------------------------------------------- temp85_0 [76] 100.0% [78] 606(12.2%) 0(0.0%) compile15 (unknown source) temp91_0 [79] 100.0% ---------------------------------------------------------------------- compile15 [78] 100.0% [79] 606(12.2%) 0(0.0%) temp91_0 (unknown source) temp118_0 [80] 100.0% ---------------------------------------------------------------------- temp91_0 [79] 100.0% [80] 606(12.2%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [81] 100.0% ---------------------------------------------------------------------- temp118_0 [80] 100.0% [81] 606(12.2%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [82] 100.0% ---------------------------------------------------------------------- expand-capturing-lifts [81] 100.0% [82] 606(12.2%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [83] 100.0% ---------------------------------------------------------------------- for-loop [84] 22.4% lambda-clause-expander [82] 77.6% [83] 606(12.2%) 0(0.0%) finish-bodys (unknown source) for-loop [84] 100.0% ---------------------------------------------------------------------- for-loop [84] 8.4% finish-bodys [83] 91.6% [84] 606(12.2%) 0(0.0%) for-loop (unknown source) loop [86] 33.3% get-body [87] 33.0% finish-bodys [83] 16.8% for-loop [84] 8.4% expand-id-application-form17 [85] 8.4% ---------------------------------------------------------------------- for-loop [84] 100.0% [85] 204(4.1%) 0(0.0%) expand-id-application-form17 (unknown source) binding-lookup52 [88] 100.0% ---------------------------------------------------------------------- for-loop [84] 100.0% [86] 202(4.1%) 0(0.0%) loop (unknown source) core-form-sym [89] 100.0% ---------------------------------------------------------------------- for-loop [84] 100.0% [87] 200(4.0%) 200(4.0%) get-body (unknown source) ---------------------------------------------------------------------- expand-id-application-form17 [85]100.0% [88] 204(4.1%) 204(4.1%) binding-lookup52 (unknown source) ---------------------------------------------------------------------- loop [86] 100.0% [89] 202(4.1%) 0(0.0%) core-form-sym (unknown source) resolve+shift28 [90] 100.0% ---------------------------------------------------------------------- core-form-sym [89] 100.0% [90] 202(4.1%) 202(4.1%) resolve+shift28 (unknown source) ----------------------------------------------------------------------