Profiling results ----------------- Total cpu time observed: 14092ms (out of 14352ms) Number of samples taken: 43 (once every 328ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== run [8] 50.0% [1] 14092(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 50.0% loop [4] 28.3% run-improve39 [5] 18.7% eval-errors [35] 2.0% oracle-error [7] 1.0% ---------------------------------------------------------------------- ??? [39] 100.0% [2] 318(2.3%) 0(0.0%) approximate9 ...e/develop/src/core/taylor.rkt:12:0 for-loop [6] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [3] 14092(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [8] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [4] 7988(56.7%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:242:2 make-exacts-intervals [9] 96.1% for-loop [12] 3.9% ---------------------------------------------------------------------- ??? [1] 100.0% [5] 5270(37.4%) 0(0.0%) run-improve39 ...ie/develop/src/mainloop.rkt:322:0 for-loop [10] 94.1% ??? [25] 5.9% ---------------------------------------------------------------------- approximate9 [2] 100.0% [6] 318(2.3%) 0(0.0%) for-loop ...rbie/develop/src/core/taylor.rkt:30:18 taylor [11] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [7] 272(1.9%) 0(0.0%) oracle-error ...erbie/develop/src/points.rkt:311:0 for-loop [13] 100.0% ---------------------------------------------------------------------- profile-thunk16 [3] 100.0% [8] 14092(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ---------------------------------------------------------------------- loop [4] 100.0% [9] 7674(54.5%) 0(0.0%) make-exacts-intervals ...elop/src/points.rkt:183:0 for-loop [14] 100.0% ---------------------------------------------------------------------- run-improve39 [5] 100.0% [10] 4958(35.2%) 0(0.0%) for-loop ...herbie/develop/src/mainloop.rkt:339:10 run-iter! [15] 100.0% ---------------------------------------------------------------------- for-loop [6] 100.0% [11] 318(2.3%) 0(0.0%) taylor ...herbie/develop/src/core/taylor.rkt:169:0 debug7 [16] 100.0% ---------------------------------------------------------------------- loop [4] 100.0% [12] 314(2.2%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:257:19 for-loop [17] 100.0% ---------------------------------------------------------------------- oracle-error [7] 100.0% [13] 272(1.9%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:312:2 map [18] 100.0% ---------------------------------------------------------------------- make-exacts-intervals [9] 100.0% [14] 7674(54.5%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:186:2 loop [19] 100.0% ---------------------------------------------------------------------- for-loop [10] 100.0% [15] 4958(35.2%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:303:0 simplify! [20] 55.9% finalize-iter! [21] 37.6% gen-series! [22] 6.4% ---------------------------------------------------------------------- taylor [11] 100.0% [16] 318(2.3%) 0(0.0%) debug7 ...tlies/herbie/develop/src/debug.rkt:102:0 ??? [25] 100.0% ---------------------------------------------------------------------- for-loop [12] 100.0% [17] 314(2.2%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:234:4 ??? [39] 100.0% ---------------------------------------------------------------------- for-loop [13] 100.0% [18] 272(1.9%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:35:13 ??? [23] 100.0% ---------------------------------------------------------------------- for-loop [14] 100.0% [19] 7674(54.5%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:168:2 ??? [37] 90.3% ??? [39] 9.7% ---------------------------------------------------------------------- run-iter! [15] 100.0% [20] 2774(19.7%) 0(0.0%) simplify! ...herbie/develop/src/mainloop.rkt:206:0 for-loop [24] 100.0% ---------------------------------------------------------------------- run-iter! [15] 100.0% [21] 1866(13.2%) 0(0.0%) finalize-iter! ...e/develop/src/mainloop.rkt:257:0 ??? [25] 100.0% ---------------------------------------------------------------------- run-iter! [15] 100.0% [22] 318(2.3%) 0(0.0%) gen-series! ...rbie/develop/src/mainloop.rkt:152:0 for-loop [26] 100.0% ---------------------------------------------------------------------- map [18] 100.0% [23] 272(1.9%) 0(0.0%) ??? ...htlies/herbie/develop/src/points.rkt:313:26 ??? [37] 100.0% ---------------------------------------------------------------------- simplify! [20] 100.0% [24] 2774(19.7%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:213:6 for-loop [27] 100.0% ---------------------------------------------------------------------- run-improve39 [5] 12.5% debug7 [16] 12.7% finalize-iter! [21] 74.8% [25] 2496(17.7%) 318(2.3%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [28] 87.3% ---------------------------------------------------------------------- gen-series! [22] 100.0% [26] 318(2.3%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:160:7 taylor-alt [29] 100.0% ---------------------------------------------------------------------- for-loop [24] 100.0% [27] 2774(19.7%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:237:8 ??? [39] 100.0% ---------------------------------------------------------------------- ??? [25] 100.0% [28] 2178(15.5%) 0(0.0%) for-loop ...ie/develop/src/core/alt-table.rkt:51:2 atab-add-altn [30] 86.0% loop [32] 14.0% ---------------------------------------------------------------------- for-loop [26] 100.0% [29] 318(2.3%) 0(0.0%) taylor-alt ...erbie/develop/src/mainloop.rkt:138:0 for-loop [31] 100.0% ---------------------------------------------------------------------- for-loop [28] 100.0% [30] 1872(13.3%) 330(2.3%) atab-add-altn ...elop/src/core/alt-table.rkt:210:0 override-at-pnts [33] 49.6% best-and-tied-at-points [34] 32.8% ---------------------------------------------------------------------- taylor-alt [29] 100.0% [31] 318(2.3%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:144:6 ??? [39] 100.0% ---------------------------------------------------------------------- for-loop [28] 100.0% [32] 306(2.2%) 306(2.2%) loop ...erbie/develop/src/core/alt-table.rkt:184:2 ---------------------------------------------------------------------- atab-add-altn [30] 100.0% [33] 928(6.6%) 0(0.0%) override-at-pnts ...p/src/core/alt-table.rkt:145:0 eval-errors [35] 100.0% ---------------------------------------------------------------------- atab-add-altn [30] 100.0% [34] 614(4.4%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:122:0 eval-errors [35] 100.0% ---------------------------------------------------------------------- ??? [1] 26.7% best-and-tied-at-points [34] 29.2% override-at-pnts [33] 44.1% [35] 2104(14.9%) 0(0.0%) eval-errors ...herbie/develop/src/points.rkt:292:0 for-loop [36] 100.0% ---------------------------------------------------------------------- eval-errors [35] 100.0% [36] 2104(14.9%) 612(4.3%) for-loop ...es/herbie/develop/src/points.rkt:294:2 ??? [37] 70.9% ---------------------------------------------------------------------- ??? [23] 3.1% for-loop [36] 17.2% loop [19] 79.7% [37] 8690(61.7%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:124:2 ??? [38] 66.0% ??? [54] 17.4% ??? [39] 16.6% ---------------------------------------------------------------------- ??? [37] 100.0% [38] 5734(40.7%) 0(0.0%) ??? ...acket/collects/racket/private/kw.rkt:592:14 ??? [54] 75.7% ??? [39] 18.7% ??? [40] 5.6% ---------------------------------------------------------------------- for-loop [31] 2.4% for-loop [17] 4.7% loop [19] 11.2% ??? [38] 16.1% for-loop [27] 20.8% ??? [37] 21.6% location-do [41] 23.2% [39] 6672(47.3%) 426(3.0%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [43] 32.9% location-do [41] 23.2% ??? [42] 20.8% loop [44] 9.7% sample-multi-bounded [45] 4.7% approximate9 [2] 2.4% ---------------------------------------------------------------------- ??? [38] 100.0% [40] 320(2.3%) 320(2.3%) ??? ...herbie/develop/src/syntax/syntax.rkt:198:17 ---------------------------------------------------------------------- location-do [41] 44.9% ??? [39] 55.1% [41] 3092(21.9%) 0(0.0%) location-do ...erbie/develop/src/programs.rkt:89:0 ??? [39] 55.1% location-do [41] 44.9% ---------------------------------------------------------------------- ??? [39] 100.0% [42] 2774(19.7%) 0(0.0%) ??? ...s/herbie/develop/src/core/simplify.rkt:31:0 iterate-egraph!7 [46] 88.5% loop [49] 11.5% ---------------------------------------------------------------------- ??? [39] 100.0% [43] 2192(15.6%) 1278(9.1%) ->flonum ...s/herbie/develop/src/programs.rkt:36:0 return/no-unsupplied [48] 27.6% list-member? [50] 14.1% ---------------------------------------------------------------------- ??? [39] 100.0% [44] 648(4.6%) 0(0.0%) loop ...s/herbie/develop/src/biginterval.rkt:346:9 ival-<2 [47] 100.0% ---------------------------------------------------------------------- ??? [39] 100.0% [45] 314(2.2%) 314(2.2%) sample-multi-bounded ...evelop/src/points.rkt:44:0 ---------------------------------------------------------------------- ??? [42] 100.0% [46] 2454(17.4%) 0(0.0%) iterate-egraph!7 ...lop/src/core/simplify.rkt:61:0 one-iter [51] 100.0% ---------------------------------------------------------------------- loop [44] 100.0% [47] 648(4.6%) 340(2.4%) ival-<2 ...erbie/develop/src/biginterval.rkt:321:0 fold-binary-pred [53] 47.5% ---------------------------------------------------------------------- ->flonum [43] 100.0% [48] 606(4.3%) 606(4.3%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 ---------------------------------------------------------------------- ??? [42] 100.0% [49] 320(2.3%) 0(0.0%) loop ...herbie/develop/src/core/simplify.rkt:195:2 for-loop [52] 100.0% ---------------------------------------------------------------------- ->flonum [43] 100.0% [50] 308(2.2%) 308(2.2%) list-member? ...llects/racket/private/set.rkt:24:0 ---------------------------------------------------------------------- iterate-egraph!7 [46] 100.0% [51] 2454(17.4%) 0(0.0%) one-iter ...bie/develop/src/core/simplify.rkt:72:0 for-loop [55] 75.5% for-loop [57] 12.4% map-enodes [58] 12.1% ---------------------------------------------------------------------- loop [49] 100.0% [52] 320(2.3%) 0(0.0%) for-loop ...e/develop/src/core/simplify.rkt:188:29 for-loop [56] 100.0% ---------------------------------------------------------------------- ival-<2 [47] 100.0% [53] 308(2.2%) 0(0.0%) fold-binary-pred ...gfloat/bigfloat-mpfr.rkt:117:0 ??? [54] 100.0% ---------------------------------------------------------------------- fold-binary-pred [53] 5.0% ??? [37] 24.5% ??? [38] 70.5% [54] 6160(43.7%) 626(4.4%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-sub [59] 32.2% mk-ival [60] 29.3% ival-div [61] 28.3% ---------------------------------------------------------------------- for-loop [55] 50.0% one-iter [51] 50.0% [55] 1852(13.1%) 1242(8.8%) for-loop ...ie/develop/src/core/simplify.rkt:83:12 for-loop [55] 50.0% match-e [62] 16.5% ---------------------------------------------------------------------- for-loop [52] 100.0% [56] 320(2.3%) 320(2.3%) for-loop ...e/develop/src/core/simplify.rkt:175:13 ---------------------------------------------------------------------- one-iter [51] 100.0% [57] 304(2.2%) 0(0.0%) for-loop ...ie/develop/src/core/simplify.rkt:123:2 for-loop [64] 100.0% ---------------------------------------------------------------------- one-iter [51] 100.0% [58] 298(2.1%) 0(0.0%) map-enodes ...ie/develop/src/core/egraph.rkt:140:0 loop [63] 100.0% ---------------------------------------------------------------------- ??? [54] 100.0% [59] 1986(14.1%) 0(0.0%) ival-sub ...erbie/develop/src/biginterval.rkt:82:0 ??? [65] 100.0% ---------------------------------------------------------------------- ??? [54] 100.0% [60] 1804(12.8%) 0(0.0%) mk-ival ...herbie/develop/src/biginterval.rkt:52:0 bf [66] 100.0% ---------------------------------------------------------------------- ??? [54] 100.0% [61] 1744(12.4%) 402(2.9%) ival-div ...rbie/develop/src/biginterval.rkt:105:0 ??? [65] 54.8% ...higher-order.rkt:361:33 [67] 22.1% ---------------------------------------------------------------------- for-loop [55] 100.0% [62] 610(4.3%) 312(2.2%) match-e ...herbie/develop/src/core/ematch.rkt:39:0 for-loop [69] 48.9% ---------------------------------------------------------------------- map-enodes [58] 2.9% loop! [68] 12.6% loop [63] 84.5% [63] 602(4.3%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:40:19 loop [63] 84.5% loop! [68] 12.6% set-precompute! [70] 2.9% ---------------------------------------------------------------------- for-loop [57] 100.0% [64] 304(2.2%) 0(0.0%) for-loop ...ie/develop/src/core/simplify.rkt:106:4 loop! [68] 100.0% ---------------------------------------------------------------------- ival-div [61] 32.5% ival-sub [59] 67.5% [65] 2942(20.9%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfdiv [71] 100.0% ---------------------------------------------------------------------- mk-ival [60] 100.0% [66] 1804(12.8%) 322(2.3%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [75] 82.2% ---------------------------------------------------------------------- ival-div [61] 100.0% [67] 386(2.7%) 0(0.0%) ...higher-order.rkt:361:33 (unknown source) ??? [72] 100.0% ---------------------------------------------------------------------- for-loop [64] 33.3% loop [63] 66.7% [68] 304(2.2%) 0(0.0%) loop! ...s/herbie/develop/src/core/enode.rkt:190:2 loop [63] 66.7% update-en-expr [73] 33.3% ---------------------------------------------------------------------- match-e [62] 100.0% [69] 298(2.1%) 298(2.1%) for-loop ...rbie/develop/src/core/ematch.rkt:52:11 ---------------------------------------------------------------------- loop [63] 100.0% [70] 298(2.1%) 0(0.0%) set-precompute! ...lop/src/core/simplify.rkt:151:0 for-loop [74] 100.0% ---------------------------------------------------------------------- ??? [65] 100.0% [71] 2942(20.9%) 0(0.0%) bfdiv ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [75] 68.2% ??? [76] 31.8% ---------------------------------------------------------------------- ...higher-order.rkt:361:33 [67]100.0% [72] 386(2.7%) 386(2.7%) ??? ...ects/racket/contract/private/guts.rkt:746:8 ---------------------------------------------------------------------- loop! [68] 100.0% [73] 304(2.2%) 0(0.0%) update-en-expr ...evelop/src/core/egraph.rkt:209:0 for-loop [77] 100.0% ---------------------------------------------------------------------- set-precompute! [70] 100.0% [74] 298(2.1%) 298(2.1%) for-loop ...ie/develop/src/core/simplify.rkt:153:2 ---------------------------------------------------------------------- bf [66] 42.5% bfdiv [71] 57.5% [75] 3488(24.8%) 3488(24.8%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ---------------------------------------------------------------------- bfdiv [71] 100.0% [76] 936(6.6%) 936(6.6%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 ---------------------------------------------------------------------- update-en-expr [73] 100.0% [77] 304(2.2%) 304(2.2%) for-loop ...rbie/develop/src/core/egraph.rkt:211:6 ----------------------------------------------------------------------