Profiling results ----------------- Total cpu time observed: 4148ms (out of 4776ms) Number of samples taken: 26 (once every 160ms) ======================================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================================= [1] 4148(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [7] 100.0% --------------------------------------------------------------------------------------- ??? [68] 100.0% [2] 804(19.4%) 0(0.0%) approximate9 ...ie/master/src/core/taylor.rkt:12:0 loop [8] 100.0% --------------------------------------------------------------------------------------- hash-ref! [77] 100.0% [3] 642(15.5%) 0(0.0%) simplify ...herbie/master/src/core/reduce.rkt:16:0 parse-loop80 [9] 51.1% debug-print [12] 24.6% f67 [13] 24.3% --------------------------------------------------------------------------------------- hash-ref! [77] 100.0% [4] 314(7.6%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:291:26 for-loop [10] 100.0% --------------------------------------------------------------------------------------- matcher [82] 100.0% [5] 170(4.1%) 0(0.0%) ??? ...s/herbie/master/src/core/matcher.rkt:130:11 for-loop [11] 100.0% --------------------------------------------------------------------------------------- loop [38] 100.0% [6] 156(3.8%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [14] 100.0% --------------------------------------------------------------------------------------- ??? [1] 100.0% [7] 4148(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [15] 100.0% --------------------------------------------------------------------------------------- approximate9 [2] 100.0% [8] 804(19.4%) 162(3.9%) loop ...ies/herbie/master/src/core/taylor.rkt:87:4 ??? [68] 79.9% --------------------------------------------------------------------------------------- parse-loop80 [9] 27.1% simplify [3] 72.9% [9] 328(7.9%) 0(0.0%) parse-loop80 (unknown source) eval-const-expr [16] 72.9% parse-loop80 [9] 27.1% --------------------------------------------------------------------------------------- ??? [4] 100.0% [10] 314(7.6%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:291:52 ??? [18] 50.3% hash-ref! [77] 49.7% --------------------------------------------------------------------------------------- ??? [5] 100.0% [11] 170(4.1%) 0(0.0%) for-loop ...bie/master/src/core/matcher.rkt:132:15 matcher [82] 100.0% --------------------------------------------------------------------------------------- simplify [3] 100.0% [12] 158(3.8%) 0(0.0%) debug-print ...s/herbie/master/src/debug.rkt:110:0 ??? [17] 100.0% --------------------------------------------------------------------------------------- simplify [3] 100.0% [13] 156(3.8%) 0(0.0%) f67 (unknown source) eval-const-expr [16] 100.0% --------------------------------------------------------------------------------------- expand-id-application-form17 [6] 100.0% [14] 156(3.8%) 0(0.0%) syntax-e/no-taint (unknown source) loop [38] 100.0% --------------------------------------------------------------------------------------- profile-thunk16 [7] 100.0% [15] 4148(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [19] 100.0% --------------------------------------------------------------------------------------- f67 [13] 32.2% parse-loop80 [9] 67.8% [16] 484(11.7%) 0(0.0%) eval-const-expr ...e/master/src/programs.rkt:118:0 temp85_0 [20] 100.0% --------------------------------------------------------------------------------------- debug-print [12] 100.0% [17] 158(3.8%) 0(0.0%) ??? .../contract/private/arrow-val-first.rkt:555:3 keyword-apply [21] 100.0% --------------------------------------------------------------------------------------- for-loop [10] 100.0% [18] 158(3.8%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:294:19 hash-ref! [77] 100.0% --------------------------------------------------------------------------------------- for-loop [79] 3.8% run [15] 96.2% [19] 4148(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [22] 55.6% prepare-points-intervals [26] 37.1% ??? [42] 3.8% eval-errors [25] 3.5% --------------------------------------------------------------------------------------- eval-const-expr [16] 100.0% [20] 484(11.7%) 0(0.0%) temp85_0 (unknown source) compile15 [23] 100.0% --------------------------------------------------------------------------------------- ??? [17] 100.0% [21] 158(3.8%) 0(0.0%) keyword-apply ...lects/racket/private/kw.rkt:455:2 keyword-procedure-extract/method [24] 100.0% --------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [19] 100.0% [22] 2464(59.4%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:346:0 for-loop [27] 71.4% simplify! [37] 15.9% prepare-points-intervals [26] 12.7% --------------------------------------------------------------------------------------- temp85_0 [20] 100.0% [23] 484(11.7%) 0(0.0%) compile15 (unknown source) temp91_0 [28] 100.0% --------------------------------------------------------------------------------------- keyword-apply [21] 100.0% [24] 158(3.8%) 158(3.8%) keyword-procedure-extract/method .../kw.rkt:1493:2 --------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [19] 100.0% [25] 144(3.5%) 0(0.0%) eval-errors .../herbie/master/src/points.rkt:179:0 for-loop [29] 100.0% --------------------------------------------------------------------------------------- run-improve47 [22] 16.8% .../more-scheme.rkt:261:28 [19] 83.2% [26] 1852(44.6%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:110:0 loop [31] 83.2% eval-prog [32] 16.8% --------------------------------------------------------------------------------------- run-improve47 [22] 100.0% [27] 1760(42.4%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:365:4 run-iter! [30] 100.0% --------------------------------------------------------------------------------------- compile15 [23] 100.0% [28] 484(11.7%) 0(0.0%) temp91_0 (unknown source) temp118_0 [33] 63.2% loop [38] 36.8% --------------------------------------------------------------------------------------- eval-errors [25] 100.0% [29] 144(3.5%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:181:2 ulp-difference [34] 100.0% --------------------------------------------------------------------------------------- for-loop [27] 100.0% [30] 1760(42.4%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:327:0 gen-series! [36] 45.7% finalize-iter! [39] 26.6% simplify! [37] 18.1% gen-rewrites! [41] 9.7% --------------------------------------------------------------------------------------- prepare-points-intervals [26] 100.0% [31] 1540(37.1%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:123:4 loop [35] 69.7% ??? [40] 30.3% --------------------------------------------------------------------------------------- prepare-points-intervals [26] 100.0% [32] 312(7.5%) 0(0.0%) eval-prog ...s/herbie/master/src/programs.rkt:83:0 loop [38] 100.0% --------------------------------------------------------------------------------------- temp91_0 [28] 100.0% [33] 306(7.4%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [44] 100.0% --------------------------------------------------------------------------------------- for-loop [29] 100.0% [34] 144(3.5%) 144(3.5%) ulp-difference ...herbie/master/src/float.rkt:20:0 --------------------------------------------------------------------------------------- loop [31] 100.0% [35] 1074(25.9%) 0(0.0%) loop ...ightlies/herbie/master/src/points.rkt:81:2 ??? [42] 100.0% --------------------------------------------------------------------------------------- run-iter! [30] 100.0% [36] 804(19.4%) 0(0.0%) gen-series! ...erbie/master/src/mainloop.rkt:160:0 for-loop [43] 100.0% --------------------------------------------------------------------------------------- run-iter! [30] 44.8% run-improve47 [22] 55.2% [37] 710(17.1%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:224:0 egraph-run [45] 100.0% --------------------------------------------------------------------------------------- syntax-e/no-taint [14] 8.0% for-loop [71] 8.0% temp91_0 [28] 13.8% loop [38] 15.9% expand-capturing-lifts [44] 21.6% eval-prog [32] 32.6% [38] 646(15.6%) 178(4.3%) loop (unknown source) expand-capturing-lifts [44] 46.4% loop [38] 15.9% expand-id-application-form17 [6] 8.0% gf [48] 8.0% for-loop [71] 7.8% --------------------------------------------------------------------------------------- run-iter! [30] 100.0% [39] 468(11.3%) 0(0.0%) finalize-iter! ...ie/master/src/mainloop.rkt:278:0 ??? [46] 100.0% --------------------------------------------------------------------------------------- loop [31] 100.0% [40] 466(11.2%) 0(0.0%) ??? ...ightlies/herbie/master/src/points.rkt:106:2 ??? [68] 67.8% do-curry [49] 32.2% --------------------------------------------------------------------------------------- run-iter! [30] 100.0% [41] 170(4.1%) 0(0.0%) gen-rewrites! ...bie/master/src/mainloop.rkt:183:0 for-loop [47] 100.0% --------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [19] 22.5% loop [35] 77.5% [42] 1386(33.4%) 316(7.6%) ??? ...htlies/herbie/master/src/programs.rkt:115:2 ??? [52] 43.4% ??? [68] 22.9% ??? [58] 10.8% --------------------------------------------------------------------------------------- gen-series! [36] 100.0% [43] 804(19.4%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:167:7 taylor-alt [50] 100.0% --------------------------------------------------------------------------------------- temp118_0 [33] 38.4% loop [38] 61.6% [44] 796(19.2%) 0(0.0%) expand-capturing-lifts (unknown source) loop [38] 41.5% lambda-clause-expander [54] 38.4% dispatch-transformer41 [56] 20.1% --------------------------------------------------------------------------------------- simplify! [37] 100.0% [45] 710(17.1%) 0(0.0%) egraph-run ...bie/master/src/core/eggmath.rkt:51:0 egraph-add-exprs [51] 100.0% --------------------------------------------------------------------------------------- finalize-iter! [39] 100.0% [46] 468(11.3%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [53] 100.0% --------------------------------------------------------------------------------------- gen-rewrites! [41] 100.0% [47] 170(4.1%) 0(0.0%) for-loop .../herbie/master/src/mainloop.rkt:191:11 rewrite-expression-head20 [55] 100.0% --------------------------------------------------------------------------------------- loop [38] 100.0% [48] 156(3.8%) 0(0.0%) gf (unknown source) propagation-apply [57] 100.0% --------------------------------------------------------------------------------------- ??? [40] 100.0% [49] 150(3.6%) 150(3.6%) do-curry ...-7.5/collects/racket/function.rkt:71:2 --------------------------------------------------------------------------------------- for-loop [43] 100.0% [50] 804(19.4%) 0(0.0%) taylor-alt ...herbie/master/src/mainloop.rkt:146:0 for-loop [59] 100.0% --------------------------------------------------------------------------------------- egraph-run [45] 100.0% [51] 710(17.1%) 0(0.0%) egraph-add-exprs ...ter/src/core/eggmath.rkt:111:0 ??? [60] 100.0% --------------------------------------------------------------------------------------- ??? [42] 100.0% [52] 602(14.5%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-sub [63] 50.2% ival-add [64] 49.8% --------------------------------------------------------------------------------------- ??? [46] 100.0% [53] 468(11.3%) 0(0.0%) for-loop ...bie/master/src/core/alt-table.rkt:55:2 atab-add-altn [61] 66.7% loop [67] 33.3% --------------------------------------------------------------------------------------- expand-capturing-lifts [44] 100.0% [54] 306(7.4%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [62] 100.0% --------------------------------------------------------------------------------------- for-loop [47] 100.0% [55] 170(4.1%) 0(0.0%) rewrite-expression-head20 ...core/matcher.rkt:87:0 rewriter [65] 100.0% --------------------------------------------------------------------------------------- expand-capturing-lifts [44] 100.0% [56] 160(3.9%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [66] 100.0% --------------------------------------------------------------------------------------- gf [48] 100.0% [57] 156(3.8%) 156(3.8%) propagation-apply (unknown source) --------------------------------------------------------------------------------------- ??? [42] 100.0% [58] 150(3.6%) 150(3.6%) ??? .../herbie/master/src/syntax/syntax.rkt:214:17 --------------------------------------------------------------------------------------- taylor-alt [50] 100.0% [59] 804(19.4%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:152:6 ??? [68] 100.0% --------------------------------------------------------------------------------------- egraph-add-exprs [51] 100.0% [60] 710(17.1%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:72:6 for-loop [69] 100.0% --------------------------------------------------------------------------------------- for-loop [53] 100.0% [61] 312(7.5%) 0(0.0%) atab-add-altn ...ster/src/core/alt-table.rkt:203:0 errors [72] 100.0% --------------------------------------------------------------------------------------- lambda-clause-expander [54] 34.7% for-loop [71] 65.3% [62] 306(7.4%) 0(0.0%) finish-bodys (unknown source) for-loop [71] 100.0% --------------------------------------------------------------------------------------- ??? [52] 100.0% [63] 302(7.3%) 0(0.0%) ival-sub ...erbie/master/src/biginterval.rkt:107:0 bfadd [70] 100.0% --------------------------------------------------------------------------------------- ??? [52] 100.0% [64] 300(7.2%) 0(0.0%) ival-add ...erbie/master/src/biginterval.rkt:101:0 bfadd [70] 100.0% --------------------------------------------------------------------------------------- matcher [82] 50.0% rewrite-expression-head20 [55] 50.0% [65] 170(4.1%) 0(0.0%) rewriter ...erbie/master/src/core/matcher.rkt:90:2 for-loop [73] 100.0% --------------------------------------------------------------------------------------- dispatch-transformer41 [56] 100.0% [66] 160(3.9%) 0(0.0%) apply-transformer52 (unknown source) apply-transformer-in-context [74] 100.0% --------------------------------------------------------------------------------------- for-loop [53] 100.0% [67] 156(3.8%) 0(0.0%) loop ...herbie/master/src/core/alt-table.rkt:177:2 map [75] 100.0% --------------------------------------------------------------------------------------- for-loop [96] 5.2% loop [8] 14.9% ??? [40] 16.8% location-do [76] 20.5% for-loop [59] 20.5% ??? [42] 22.1% [68] 1438(34.7%) 300(7.2%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [76] 20.5% approximate9 [2] 20.5% sample-multi-bounded [78] 16.8% hash-ref! [77] 14.9% mk-ival [83] 11.7% --------------------------------------------------------------------------------------- ??? [60] 100.0% [69] 710(17.1%) 710(17.1%) for-loop ...rbie/master/src/core/simplify.rkt:91:2 --------------------------------------------------------------------------------------- ival-add [64] 49.8% ival-sub [63] 50.2% [70] 602(14.5%) 150(3.6%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [80] 50.2% ??? [97] 24.9% --------------------------------------------------------------------------------------- for-loop [71] 10.9% run-module-instance!125 [86] 16.6% loop [38] 16.6% finish-bodys [62] 55.9% [71] 458(11.0%) 0(0.0%) for-loop (unknown source) finish-bodys [62] 38.2% run-module-instance!125 [86] 16.6% temp37_0 [85] 16.6% for-loop [71] 10.9% expand-implicit [87] 10.9% loop [38] 6.8% --------------------------------------------------------------------------------------- atab-add-altn [61] 100.0% [72] 312(7.5%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:201:0 for-loop [79] 100.0% --------------------------------------------------------------------------------------- rewriter [65] 100.0% [73] 170(4.1%) 0(0.0%) for-loop ...erbie/master/src/core/matcher.rkt:92:4 matcher [82] 50.0% for-loop [81] 50.0% --------------------------------------------------------------------------------------- apply-transformer52 [66] 100.0% [74] 160(3.9%) 160(3.9%) apply-transformer-in-context (unknown source) --------------------------------------------------------------------------------------- loop [67] 100.0% [75] 156(3.8%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 loop [84] 100.0% --------------------------------------------------------------------------------------- location-do [76] 11.1% ??? [68] 88.9% [76] 804(19.4%) 0(0.0%) location-do ...herbie/master/src/programs.rkt:64:0 ??? [68] 88.9% location-do [76] 11.1% --------------------------------------------------------------------------------------- for-loop [10] 6.1% ??? [93] 6.1% ??? [18] 8.2% ??? [88] 39.8% ??? [68] 39.8% [77] 642(15.5%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [88] 39.8% simplify [3] 39.8% ??? [4] 14.3% ??? [93] 6.1% --------------------------------------------------------------------------------------- ??? [68] 100.0% [78] 316(7.6%) 0(0.0%) sample-multi-bounded ...master/src/points.rkt:15:0 random-ranges [91] 52.5% for-loop [96] 47.5% --------------------------------------------------------------------------------------- errors [72] 100.0% [79] 312(7.5%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:203:2 .../more-scheme.rkt:261:28 [19] 100.0% --------------------------------------------------------------------------------------- bfadd [70] 100.0% [80] 302(7.3%) 302(7.3%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 --------------------------------------------------------------------------------------- for-loop [73] 100.0% [81] 170(4.1%) 0(0.0%) for-loop ...erbie/master/src/core/matcher.rkt:99:8 fix-up-variables [89] 100.0% --------------------------------------------------------------------------------------- for-loop [11] 50.0% for-loop [73] 50.0% [82] 170(4.1%) 0(0.0%) matcher ...erbie/master/src/core/matcher.rkt:118:2 ??? [5] 50.0% rewriter [65] 50.0% --------------------------------------------------------------------------------------- ??? [68] 100.0% [83] 168(4.1%) 0(0.0%) mk-ival .../herbie/master/src/biginterval.rkt:65:0 bf [90] 100.0% --------------------------------------------------------------------------------------- loop [84] 50.0% map [75] 50.0% [84] 156(3.8%) 0(0.0%) loop ...-7.5/collects/racket/private/map.rkt:40:19 loop [84] 50.0% ??? [92] 50.0% --------------------------------------------------------------------------------------- for-loop [71] 100.0% [85] 152(3.7%) 0(0.0%) temp37_0 (unknown source) [running body] [94] 100.0% --------------------------------------------------------------------------------------- for-loop [71] 100.0% [86] 152(3.7%) 0(0.0%) run-module-instance!125 (unknown source) for-loop [71] 100.0% --------------------------------------------------------------------------------------- for-loop [71] 100.0% [87] 150(3.6%) 0(0.0%) expand-implicit (unknown source) binding-lookup52 [95] 100.0% --------------------------------------------------------------------------------------- hash-ref! [77] 100.0% [88] 642(15.5%) 0(0.0%) ??? ...ies/herbie/master/src/core/taylor.rkt:45:15 hash-ref! [77] 100.0% --------------------------------------------------------------------------------------- for-loop [81] 100.0% [89] 170(4.1%) 0(0.0%) fix-up-variables ...ter/src/core/matcher.rkt:111:2 for-loop [98] 100.0% --------------------------------------------------------------------------------------- mk-ival [83] 100.0% [90] 168(4.1%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 ??? [97] 100.0% --------------------------------------------------------------------------------------- sample-multi-bounded [78] 100.0% [91] 166(4.0%) 0(0.0%) random-ranges ...erbie/master/src/common.rkt:171:0 cons/c [99] 100.0% --------------------------------------------------------------------------------------- loop [84] 100.0% [92] 156(3.8%) 156(3.8%) ??? ...herbie/master/src/core/alt-table.rkt:194:12 --------------------------------------------------------------------------------------- hash-ref! [77] 100.0% [93] 156(3.8%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:344:33 hash-ref! [77] 100.0% --------------------------------------------------------------------------------------- temp37_0 [85] 100.0% [94] 152(3.7%) 0(0.0%) [running body] .../collects/racket/format.rkt":##f .get-syntax-literal! [100] 100.0% --------------------------------------------------------------------------------------- expand-implicit [87] 100.0% [95] 150(3.6%) 150(3.6%) binding-lookup52 (unknown source) --------------------------------------------------------------------------------------- sample-multi-bounded [78] 100.0% [96] 150(3.6%) 0(0.0%) for-loop ...lies/herbie/master/src/points.rkt:23:4 ??? [68] 100.0% --------------------------------------------------------------------------------------- bfadd [70] 47.2% bf [90] 52.8% [97] 318(7.7%) 318(7.7%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 --------------------------------------------------------------------------------------- fix-up-variables [89] 100.0% [98] 170(4.1%) 0(0.0%) for-loop ...erbie/master/src/core/matcher.rkt:42:9 for-loop [101] 100.0% --------------------------------------------------------------------------------------- random-ranges [91] 100.0% [99] 166(4.0%) 0(0.0%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [102] 100.0% --------------------------------------------------------------------------------------- [running body] [94] 100.0% [100] 152(3.7%) 0(0.0%) .get-syntax-literal! (unknown source) .deserialize-syntax [103] 100.0% --------------------------------------------------------------------------------------- for-loop [98] 100.0% [101] 170(4.1%) 0(0.0%) for-loop ...erbie/master/src/core/matcher.rkt:27:9 core457 [104] 100.0% --------------------------------------------------------------------------------------- cons/c [99] 100.0% [102] 166(4.0%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [105] 100.0% --------------------------------------------------------------------------------------- .get-syntax-literal! [100] 100.0% [103] 152(3.7%) 152(3.7%) .deserialize-syntax (unknown source) --------------------------------------------------------------------------------------- for-loop [101] 100.0% [104] 170(4.1%) 0(0.0%) core457 ...acket/contract/private/arr-i.rkt:976:19 successfully-got-the-right-kind-of-function [106]100.0% --------------------------------------------------------------------------------------- coerce-contract [102] 100.0% [105] 166(4.0%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [107] 100.0% --------------------------------------------------------------------------------------- core457 [104] 100.0% [106] 170(4.1%) 170(4.1%) successfully-got-the-right-kind-of-function ...5:4 --------------------------------------------------------------------------------------- coerce-contract/f [105] 100.0% [107] 166(4.0%) 166(4.0%) coerce-simple-value ...ract/private/guts.rkt:385:0 ---------------------------------------------------------------------------------------