Profiling results ----------------- Total cpu time observed: 12390ms (out of 12780ms) Number of samples taken: 33 (once every 375ms) ======================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================== run [13] 50.0% [1] 12390(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [5] 50.0% loop [6] 38.3% run-improve39 [7] 4.1% eval-errors [8] 4.0% oracle-error [9] 3.6% ------------------------------------------------------------------------ for-loop [66] 100.0% [2] 256(2.1%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [10] 100.0% ------------------------------------------------------------------------ ??? [48] 100.0% [3] 254(2.1%) 0(0.0%) approximate9 ...e/develop/src/core/taylor.rkt:12:0 for-loop [11] 100.0% ------------------------------------------------------------------------ loop [70] 100.0% [4] 252(2.0%) 0(0.0%) core-form-sym (unknown source) resolve+shift28 [12] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [5] 12390(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [13] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [6] 9484(76.5%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:167:2 loop [23] 65.8% loop [14] 21.8% for-loop [18] 5.3% make-exacts* [24] 3.9% make-exacts [19] 3.1% ------------------------------------------------------------------------ ??? [1] 100.0% [7] 1024(8.3%) 0(0.0%) run-improve39 ...ie/develop/src/mainloop.rkt:287:0 for-loop [17] 75.0% setup-prog!32 [20] 25.0% ------------------------------------------------------------------------ ??? [1] 100.0% [8] 994(8.0%) 0(0.0%) eval-errors ...herbie/develop/src/points.rkt:208:0 for-loop [15] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [9] 888(7.2%) 0(0.0%) oracle-error ...erbie/develop/src/points.rkt:227:0 for-loop [16] 100.0% ------------------------------------------------------------------------ syntax-e [2] 100.0% [10] 256(2.1%) 0(0.0%) syntax-e/no-taint (unknown source) loop [70] 100.0% ------------------------------------------------------------------------ approximate9 [3] 100.0% [11] 254(2.1%) 0(0.0%) for-loop ...rbie/develop/src/core/taylor.rkt:30:18 taylor [21] 100.0% ------------------------------------------------------------------------ core-form-sym [4] 100.0% [12] 252(2.0%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [22] 100.0% ------------------------------------------------------------------------ profile-thunk16 [5] 100.0% [13] 12390(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------ loop [6] 100.0% [14] 2072(16.7%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:125:2 loop [23] 58.1% make-exacts* [24] 29.8% eval-prog [52] 12.1% ------------------------------------------------------------------------ eval-errors [8] 100.0% [15] 994(8.0%) 328(2.6%) for-loop ...es/herbie/develop/src/points.rkt:210:2 ??? [35] 67.0% ------------------------------------------------------------------------ oracle-error [9] 100.0% [16] 888(7.2%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:228:2 loop [30] 100.0% ------------------------------------------------------------------------ run-improve39 [7] 100.0% [17] 768(6.2%) 0(0.0%) for-loop ...herbie/develop/src/mainloop.rkt:304:10 run-iter! [25] 100.0% ------------------------------------------------------------------------ loop [6] 100.0% [18] 506(4.1%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:182:19 for-loop [26] 100.0% ------------------------------------------------------------------------ loop [6] 100.0% [19] 294(2.4%) 0(0.0%) make-exacts ...herbie/develop/src/points.rkt:123:0 debug7 [27] 100.0% ------------------------------------------------------------------------ run-improve39 [7] 100.0% [20] 256(2.1%) 0(0.0%) setup-prog!32 ...bie/develop/src/mainloop.rkt:63:0 ??? [36] 100.0% ------------------------------------------------------------------------ map [29] 50.0% for-loop [11] 50.0% [21] 254(2.1%) 0(0.0%) taylor ...herbie/develop/src/core/taylor.rkt:169:0 map [29] 50.0% debug-print [28] 50.0% ------------------------------------------------------------------------ resolve+shift28 [12] 100.0% [22] 252(2.0%) 0(0.0%) fallback-loop (unknown source) for-loop [66] 100.0% ------------------------------------------------------------------------ loop [14] 16.2% loop [6] 83.8% [23] 7444(60.1%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:108:4 loop [30] 100.0% ------------------------------------------------------------------------ loop [6] 37.6% loop [14] 62.4% [24] 990(8.0%) 0(0.0%) make-exacts* ...erbie/develop/src/points.rkt:105:0 loop [30] 74.5% eval-prog [52] 25.5% ------------------------------------------------------------------------ for-loop [17] 100.0% [25] 768(6.2%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:268:0 finalize-iter! [31] 66.9% gen-series! [34] 33.1% ------------------------------------------------------------------------ for-loop [18] 100.0% [26] 506(4.1%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:159:4 parse-loop209 [32] 50.2% ??? [48] 49.8% ------------------------------------------------------------------------ make-exacts [19] 100.0% [27] 294(2.4%) 294(2.4%) debug7 ...tlies/herbie/develop/src/debug.rkt:102:0 ------------------------------------------------------------------------ taylor [21] 100.0% [28] 254(2.1%) 0(0.0%) debug-print .../herbie/develop/src/debug.rkt:107:0 ??? [33] 100.0% ------------------------------------------------------------------------ taylor [21] 100.0% [29] 254(2.1%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:35:13 taylor [21] 100.0% ------------------------------------------------------------------------ make-exacts* [24] 0.1% loop [23] 0.4% ??? [35] 3.7% for-loop [16] 9.4% loop [30] 86.4% [30] 9408(75.9%) 996(8.0%) loop ...cket/collects/racket/private/map.rkt:40:19 loop [30] 86.4% ??? [35] 6.5% ??? [48] 3.8% bf [39] 0.0% ------------------------------------------------------------------------ run-iter! [25] 100.0% [31] 514(4.1%) 0(0.0%) finalize-iter! ...e/develop/src/mainloop.rkt:222:0 ??? [36] 100.0% ------------------------------------------------------------------------ for-loop [26] 100.0% [32] 254(2.1%) 254(2.1%) parse-loop209 .../racket/match/compiler.rkt:418:15 ------------------------------------------------------------------------ debug-print [28] 100.0% [33] 254(2.1%) 0(0.0%) ??? .../contract/private/arrow-val-first.rkt:428:3 ~r78 [37] 100.0% ------------------------------------------------------------------------ run-iter! [25] 100.0% [34] 254(2.1%) 0(0.0%) gen-series! ...rbie/develop/src/mainloop.rkt:152:0 for-loop [38] 100.0% ------------------------------------------------------------------------ for-loop [15] 7.9% loop [30] 92.1% [35] 8484(68.5%) 1222(9.9%) ??? ...tlies/herbie/develop/src/programs.rkt:129:2 bf [39] 41.7% loop [30] 32.1% ??? [48] 7.4% ??? [41] 4.4% ------------------------------------------------------------------------ setup-prog!32 [20] 33.2% finalize-iter! [31] 66.8% [36] 770(6.2%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [40] 66.8% make-alt-table [42] 33.2% ------------------------------------------------------------------------ ??? [33] 100.0% [37] 254(2.1%) 254(2.1%) ~r78 ...92/racket/collects/racket/format.rkt:189:0 ------------------------------------------------------------------------ gen-series! [34] 100.0% [38] 254(2.1%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:158:7 taylor-alt [43] 100.0% ------------------------------------------------------------------------ loop [30] 32.3% ??? [35] 67.7% [39] 5232(42.2%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [56] 54.4% ??? [44] 45.6% ------------------------------------------------------------------------ ??? [36] 100.0% [40] 514(4.1%) 0(0.0%) for-loop ...ie/develop/src/core/alt-table.rkt:51:2 atab-add-altn [45] 100.0% ------------------------------------------------------------------------ ??? [35] 100.0% [41] 372(3.0%) 0(0.0%) ??? ...acket/collects/racket/private/kw.rkt:592:14 bf* [46] 100.0% ------------------------------------------------------------------------ ??? [36] 100.0% [42] 256(2.1%) 256(2.1%) make-alt-table ...elop/src/core/alt-table.rkt:32:0 ------------------------------------------------------------------------ for-loop [38] 100.0% [43] 254(2.1%) 0(0.0%) taylor-alt ...erbie/develop/src/mainloop.rkt:137:0 for-loop [47] 100.0% ------------------------------------------------------------------------ bf [39] 100.0% [44] 2384(19.2%) 2384(19.2%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------ for-loop [40] 100.0% [45] 514(4.1%) 0(0.0%) atab-add-altn ...elop/src/core/alt-table.rkt:210:0 best-and-tied-at-points [49] 100.0% ------------------------------------------------------------------------ ??? [41] 100.0% [46] 372(3.0%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [50] 100.0% ------------------------------------------------------------------------ taylor-alt [43] 100.0% [47] 254(2.1%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:143:6 ??? [48] 100.0% ------------------------------------------------------------------------ location-do [54] 5.2% for-loop [47] 5.2% for-loop [26] 10.4% ??? [35] 25.8% loop [30] 53.3% [48] 2420(19.5%) 338(2.7%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [51] 65.1% sample-multi-bounded [55] 10.4% location-do [54] 5.2% approximate9 [3] 5.2% ------------------------------------------------------------------------ atab-add-altn [45] 100.0% [49] 514(4.1%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:122:0 eval-prog [52] 100.0% ------------------------------------------------------------------------ bf* [46] 100.0% [50] 372(3.0%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [53] 100.0% ------------------------------------------------------------------------ ??? [48] 100.0% [51] 1576(12.7%) 872(7.0%) ->flonum ...s/herbie/develop/src/programs.rkt:36:0 return/no-unsupplied [58] 44.7% ------------------------------------------------------------------------ loop [14] 24.6% make-exacts* [24] 24.8% best-and-tied-at-points [49] 50.6% [52] 1016(8.2%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:109:0 temp68_2 [57] 75.2% loop [70] 24.8% ------------------------------------------------------------------------ ??? [50] 100.0% [53] 372(3.0%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [56] 100.0% ------------------------------------------------------------------------ ??? [48] 100.0% [54] 254(2.1%) 0(0.0%) location-do ...erbie/develop/src/programs.rkt:90:0 ??? [48] 100.0% ------------------------------------------------------------------------ ??? [48] 100.0% [55] 252(2.0%) 0(0.0%) sample-multi-bounded ...evelop/src/points.rkt:44:0 for-loop [59] 100.0% ------------------------------------------------------------------------ bfmul [53] 11.6% bf [39] 88.4% [56] 3220(26.0%) 3220(26.0%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------ eval-prog [52] 100.0% [57] 764(6.2%) 0(0.0%) temp68_2 (unknown source) compile16 [60] 100.0% ------------------------------------------------------------------------ ->flonum [51] 100.0% [58] 704(5.7%) 704(5.7%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 ------------------------------------------------------------------------ sample-multi-bounded [55] 100.0% [59] 252(2.0%) 252(2.0%) for-loop ...ies/herbie/develop/src/points.rkt:47:4 ------------------------------------------------------------------------ temp68_2 [57] 100.0% [60] 764(6.2%) 0(0.0%) compile16 (unknown source) temp74_0 [61] 100.0% ------------------------------------------------------------------------ compile16 [60] 100.0% [61] 764(6.2%) 0(0.0%) temp74_0 (unknown source) expand-single [62] 100.0% ------------------------------------------------------------------------ temp74_0 [61] 100.0% [62] 764(6.2%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [63] 100.0% ------------------------------------------------------------------------ loop [70] 24.8% expand-single [62] 75.2% [63] 1016(8.2%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [64] 75.2% dispatch-transformer41 [67] 24.8% ------------------------------------------------------------------------ expand-capturing-lifts [63] 100.0% [64] 764(6.2%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [65] 100.0% ------------------------------------------------------------------------ lambda-clause-expander [64] 20.5% for-loop [66] 79.5% [65] 764(6.2%) 0(0.0%) finish-bodys (unknown source) for-loop [66] 100.0% ------------------------------------------------------------------------ for-loop [66] 8.3% fallback-loop [22] 24.8% finish-bodys [65] 66.9% [66] 1016(8.2%) 252(2.0%) for-loop (unknown source) finish-bodys [65] 53.8% for-loop [66] 8.3% syntax-e [2] 6.3% expand-body7 [68] 4.9% dispatch-transformer41 [67] 2.0% ------------------------------------------------------------------------ expand-capturing-lifts [63] 49.4% for-loop [66] 50.6% [67] 510(4.1%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [69] 100.0% ------------------------------------------------------------------------ for-loop [66] 100.0% [68] 250(2.0%) 250(2.0%) expand-body7 (unknown source) ------------------------------------------------------------------------ dispatch-transformer41 [67] 100.0% [69] 510(4.1%) 0(0.0%) apply-transformer52 (unknown source) apply-transformer-in-context [71] 50.6% loop [70] 49.4% ------------------------------------------------------------------------ apply-transformer52 [69] 24.8% eval-prog [52] 24.8% syntax-e/no-taint [10] 50.4% [70] 508(4.1%) 0(0.0%) loop (unknown source) gf [73] 50.4% expand-capturing-lifts [63] 24.8% core-form-sym [4] 24.8% ------------------------------------------------------------------------ apply-transformer52 [69] 100.0% [71] 258(2.1%) 0(0.0%) apply-transformer-in-context (unknown source) parse-app [72] 100.0% ------------------------------------------------------------------------ apply-transformer-in-context [71]100.0% [72] 258(2.1%) 0(0.0%) parse-app ...collects/racket/private/kw.rkt:1105:2 check-loc [74] 100.0% ------------------------------------------------------------------------ loop [70] 100.0% [73] 256(2.1%) 0(0.0%) gf (unknown source) propagation-apply [75] 100.0% ------------------------------------------------------------------------ parse-app [72] 100.0% [74] 258(2.1%) 258(2.1%) check-loc ...cts/racket/private/template.rkt:602:0 ------------------------------------------------------------------------ gf [73] 100.0% [75] 256(2.1%) 256(2.1%) propagation-apply (unknown source) ------------------------------------------------------------------------