Profiling results ----------------- Total cpu time observed: 7452ms (out of 7568ms) Number of samples taken: 37 (once every 201ms) ===================================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ===================================================================================== [1] 7452(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [7] 100.0% ------------------------------------------------------------------------------------- ??? [65] 100.0% [2] 1260(16.9%) 0(0.0%) approximate9 ...-pow-test/src/core/taylor.rkt:11:0 loop [8] 85.1% for-loop [12] 14.9% ------------------------------------------------------------------------------------- hash-ref! [21] 100.0% [3] 630(8.5%) 0(0.0%) ??? ...ie/ival-pow-test/src/core/taylor.rkt:300:23 for-loop [9] 100.0% ------------------------------------------------------------------------------------- hash-ref! [21] 100.0% [4] 220(3.0%) 0(0.0%) ??? ...ie/ival-pow-test/src/core/taylor.rkt:290:26 for-loop [10] 100.0% ------------------------------------------------------------------------------------- hash-ref! [21] 100.0% [5] 204(2.7%) 0(0.0%) f40 (unknown source) map [11] 100.0% ------------------------------------------------------------------------------------- matcher [80] 100.0% [6] 158(2.1%) 0(0.0%) ??? ...e/ival-pow-test/src/core/matcher.rkt:127:11 for-loop [13] 100.0% ------------------------------------------------------------------------------------- ??? [1] 100.0% [7] 7452(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [14] 100.0% ------------------------------------------------------------------------------------- approximate9 [2] 100.0% [8] 1072(14.4%) 0(0.0%) loop ...bie/ival-pow-test/src/core/taylor.rkt:86:4 hash-ref! [21] 58.2% ??? [65] 41.8% ------------------------------------------------------------------------------------- ??? [3] 100.0% [9] 630(8.5%) 0(0.0%) for-loop ...al-pow-test/src/core/taylor.rkt:303:27 hash-ref! [21] 100.0% ------------------------------------------------------------------------------------- ??? [4] 100.0% [10] 220(3.0%) 0(0.0%) for-loop ...al-pow-test/src/core/taylor.rkt:290:52 hash-ref! [21] 100.0% ------------------------------------------------------------------------------------- f40 [5] 100.0% [11] 204(2.7%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 parse-loop74 [15] 100.0% ------------------------------------------------------------------------------------- approximate9 [2] 100.0% [12] 188(2.5%) 0(0.0%) for-loop ...val-pow-test/src/core/taylor.rkt:29:18 taylor-quotient [16] 100.0% ------------------------------------------------------------------------------------- ??? [6] 100.0% [13] 158(2.1%) 0(0.0%) for-loop ...l-pow-test/src/core/matcher.rkt:129:15 matcher [80] 100.0% ------------------------------------------------------------------------------------- profile-thunk16 [7] 100.0% [14] 7452(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% ------------------------------------------------------------------------------------- map [11] 33.2% hash-ref! [21] 66.8% [15] 614(8.2%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [18] 100.0% ------------------------------------------------------------------------------------- for-loop [12] 100.0% [16] 188(2.5%) 0(0.0%) taylor-quotient ...-test/src/core/taylor.rkt:333:0 first-nonzero-exp [19] 100.0% ------------------------------------------------------------------------------------- for-loop [73] 7.8% run [14] 92.2% [17] 7452(100.0%) 200(2.7%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [20] 66.9% prepare-points-intervals [22] 14.1% errors [66] 5.4% get-final-combination [24] 3.1% oracle-error [25] 2.7% ??? [65] 2.6% ??? [23] 2.5% ulp-difference [26] 1.3% ------------------------------------------------------------------------------------- f61 [38] 42.1% parse-loop74 [15] 57.9% [18] 1060(14.2%) 0(0.0%) eval-const-expr ...pow-test/src/programs.rkt:120:0 temp85_0 [72] 100.0% ------------------------------------------------------------------------------------- taylor-quotient [16] 100.0% [19] 188(2.5%) 0(0.0%) first-nonzero-exp ...est/src/core/taylor.rkt:265:0 hash-ref! [21] 100.0% ------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [20] 5362(72.0%) 0(0.0%) run-improve47 ...l-pow-test/src/mainloop.rkt:346:0 for-loop [27] 100.0% ------------------------------------------------------------------------------------- for-loop [10] 2.9% ??? [33] 2.9% ??? [32] 4.4% first-nonzero-exp [19] 7.5% ??? [29] 12.7% for-loop [9] 14.8% loop [8] 16.2% ??? [65] 38.6% [21] 1260(16.9%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [29] 30.6% ??? [30] 16.2% ??? [3] 14.8% parse-loop74 [15] 11.9% taylor [35] 7.9% f40 [5] 5.4% ??? [32] 4.4% ??? [33] 2.9% ??? [4] 2.9% f61 [38] 2.9% ------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [22] 1054(14.1%) 0(0.0%) prepare-points-intervals ...t/src/points.rkt:120:0 loop [28] 100.0% ------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [23] 376(5.0%) 376(5.0%) ??? .../ival-pow-test/src/syntax/syntax.rkt:214:17 ------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [24] 230(3.1%) 0(0.0%) get-final-combination ...st/src/mainloop.rkt:371:0 infer-splitpoints [31] 100.0% ------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [25] 202(2.7%) 0(0.0%) oracle-error ...ival-pow-test/src/points.rkt:177:0 for-loop [34] 100.0% ------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [17] 100.0% [26] 194(2.6%) 194(2.6%) ulp-difference ...ival-pow-test/src/float.rkt:19:0 ------------------------------------------------------------------------------------- run-improve47 [20] 100.0% [27] 5362(72.0%) 0(0.0%) for-loop ...e/ival-pow-test/src/mainloop.rkt:365:4 run-iter! [36] 100.0% ------------------------------------------------------------------------------------- prepare-points-intervals [22] 100.0% [28] 1054(14.1%) 194(2.6%) loop .../herbie/ival-pow-test/src/points.rkt:132:4 loop [37] 62.0% ??? [40] 19.5% ------------------------------------------------------------------------------------- hash-ref! [21] 100.0% [29] 872(11.7%) 0(0.0%) ??? ...bie/ival-pow-test/src/core/taylor.rkt:44:15 hash-ref! [21] 74.1% f61 [38] 25.9% ------------------------------------------------------------------------------------- hash-ref! [21] 100.0% [30] 624(8.4%) 0(0.0%) ??? ...bie/ival-pow-test/src/core/taylor.rkt:67:15 ??? [65] 100.0% ------------------------------------------------------------------------------------- get-final-combination [24] 100.0% [31] 230(3.1%) 0(0.0%) infer-splitpoints ...est/src/core/regimes.rkt:33:0 for-loop [39] 100.0% ------------------------------------------------------------------------------------- hash-ref! [21] 100.0% [32] 222(3.0%) 0(0.0%) ??? ...ie/ival-pow-test/src/core/taylor.rkt:327:33 hash-ref! [21] 100.0% ------------------------------------------------------------------------------------- hash-ref! [21] 100.0% [33] 220(3.0%) 0(0.0%) ??? ...ie/ival-pow-test/src/core/taylor.rkt:343:33 hash-ref! [21] 100.0% ------------------------------------------------------------------------------------- oracle-error [25] 100.0% [34] 202(2.7%) 0(0.0%) for-loop ...bie/ival-pow-test/src/points.rkt:178:2 loop [91] 100.0% ------------------------------------------------------------------------------------- hash-ref! [21] 33.3% taylor [35] 66.7% [35] 200(2.7%) 0(0.0%) taylor .../ival-pow-test/src/core/taylor.rkt:169:0 taylor [35] 66.7% debug5 [41] 33.3% ------------------------------------------------------------------------------------- for-loop [27] 100.0% [36] 5362(72.0%) 0(0.0%) run-iter! .../ival-pow-test/src/mainloop.rkt:327:0 finalize-iter! [42] 54.2% gen-series! [43] 23.5% simplify! [44] 15.7% gen-rewrites! [45] 6.6% ------------------------------------------------------------------------------------- loop [28] 100.0% [37] 654(8.8%) 214(2.9%) loop ...s/herbie/ival-pow-test/src/points.rkt:79:2 ??? [65] 67.3% ------------------------------------------------------------------------------------- hash-ref! [21] 49.3% ??? [29] 50.7% [38] 446(6.0%) 0(0.0%) f61 (unknown source) eval-const-expr [18] 100.0% ------------------------------------------------------------------------------------- infer-splitpoints [31] 100.0% [39] 230(3.1%) 0(0.0%) for-loop ...val-pow-test/src/core/regimes.rkt:45:6 option-on-expr [46] 100.0% ------------------------------------------------------------------------------------- loop [28] 100.0% [40] 206(2.8%) 0(0.0%) ??? ...s/herbie/ival-pow-test/src/points.rkt:113:6 sample-multi-bounded [47] 100.0% ------------------------------------------------------------------------------------- taylor [35] 100.0% [41] 200(2.7%) 200(2.7%) debug5 ...herbie/ival-pow-test/src/debug.rkt:102:0 ------------------------------------------------------------------------------------- run-iter! [36] 100.0% [42] 2908(39.0%) 0(0.0%) finalize-iter! ...-pow-test/src/mainloop.rkt:278:0 ??? [48] 100.0% ------------------------------------------------------------------------------------- run-iter! [36] 100.0% [43] 1260(16.9%) 0(0.0%) gen-series! ...val-pow-test/src/mainloop.rkt:160:0 for-loop [49] 100.0% ------------------------------------------------------------------------------------- run-iter! [36] 100.0% [44] 840(11.3%) 0(0.0%) simplify! .../ival-pow-test/src/mainloop.rkt:224:0 ??? [50] 100.0% ------------------------------------------------------------------------------------- run-iter! [36] 100.0% [45] 354(4.8%) 0(0.0%) gen-rewrites! ...l-pow-test/src/mainloop.rkt:183:0 for-loop [52] 55.4% for-loop [53] 44.6% ------------------------------------------------------------------------------------- for-loop [39] 100.0% [46] 230(3.1%) 0(0.0%) option-on-expr ...-test/src/core/regimes.rkt:124:0 sort-context-on-expr [51] 100.0% ------------------------------------------------------------------------------------- ??? [40] 100.0% [47] 206(2.8%) 206(2.8%) sample-multi-bounded ...w-test/src/points.rkt:14:0 ------------------------------------------------------------------------------------- finalize-iter! [42] 100.0% [48] 2908(39.0%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [54] 100.0% ------------------------------------------------------------------------------------- gen-series! [43] 100.0% [49] 1260(16.9%) 0(0.0%) for-loop ...e/ival-pow-test/src/mainloop.rkt:167:7 taylor-alt [55] 100.0% ------------------------------------------------------------------------------------- simplify! [44] 100.0% [50] 840(11.3%) 0(0.0%) ??? ...ie/ival-pow-test/src/core/simplify.rkt:42:0 egraph-run [56] 100.0% ------------------------------------------------------------------------------------- option-on-expr [46] 100.0% [51] 230(3.1%) 0(0.0%) sort-context-on-expr ...src/core/regimes.rkt:117:0 ??? [57] 100.0% ------------------------------------------------------------------------------------- gen-rewrites! [45] 100.0% [52] 196(2.6%) 0(0.0%) for-loop ...e/ival-pow-test/src/mainloop.rkt:208:4 for-loop [58] 100.0% ------------------------------------------------------------------------------------- gen-rewrites! [45] 100.0% [53] 158(2.1%) 0(0.0%) for-loop .../ival-pow-test/src/mainloop.rkt:191:11 rewrite-expression-head24 [59] 100.0% ------------------------------------------------------------------------------------- ??? [48] 100.0% [54] 2908(39.0%) 0(0.0%) for-loop ...l-pow-test/src/core/alt-table.rkt:46:2 atab-add-altn [60] 86.0% override-at-pnts [67] 7.4% errors [66] 6.6% ------------------------------------------------------------------------------------- for-loop [49] 100.0% [55] 1260(16.9%) 0(0.0%) taylor-alt ...ival-pow-test/src/mainloop.rkt:146:0 for-loop [61] 100.0% ------------------------------------------------------------------------------------- ??? [50] 100.0% [56] 840(11.3%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [62] 100.0% ------------------------------------------------------------------------------------- sort-context-on-expr [51] 100.0% [57] 230(3.1%) 0(0.0%) ??? ...-7.5/collects/racket/private/sort.rkt:369:3 loop [63] 100.0% ------------------------------------------------------------------------------------- for-loop [52] 100.0% [58] 196(2.6%) 0(0.0%) for-loop ...e/ival-pow-test/src/mainloop.rkt:209:6 ??? [65] 100.0% ------------------------------------------------------------------------------------- for-loop [53] 100.0% [59] 158(2.1%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [64] 100.0% ------------------------------------------------------------------------------------- for-loop [54] 100.0% [60] 2502(33.6%) 224(3.0%) atab-add-altn ...test/src/core/alt-table.rkt:194:0 errors [66] 52.2% override-at-pnts [67] 16.5% for-loop [69] 13.7% loop [70] 8.6% ------------------------------------------------------------------------------------- taylor-alt [55] 100.0% [61] 1260(16.9%) 0(0.0%) for-loop ...e/ival-pow-test/src/mainloop.rkt:152:6 ??? [65] 100.0% ------------------------------------------------------------------------------------- egraph-run [56] 100.0% [62] 840(11.3%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [68] 74.3% loop [91] 25.7% ------------------------------------------------------------------------------------- ??? [57] 100.0% [63] 230(3.1%) 0(0.0%) loop ...7.5/collects/racket/private/sort.rkt:96:12 ??? [65] 100.0% ------------------------------------------------------------------------------------- rewrite-expression-head24 [59] 33.3% matcher [80] 66.7% [64] 158(2.1%) 158(2.1%) rewriter ...val-pow-test/src/core/matcher.rkt:87:2 for-loop [71] 66.7% ------------------------------------------------------------------------------------- loop [8] 5.9% for-loop [58] 7.8% ??? [30] 8.3% loop [63] 9.1% .../more-scheme.rkt:261:28 [17] 15.5% loop [37] 17.5% location-do [74] 17.9% for-loop [61] 17.9% [65] 2516(33.8%) 620(8.3%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [74] 17.9% approximate9 [2] 17.9% ival-mult [77] 17.5% hash-ref! [21] 14.2% successfully-got-the-right-kind-of-function [78] 7.8% ------------------------------------------------------------------------------------- for-loop [54] 9.1% .../more-scheme.rkt:261:28 [17] 28.7% atab-add-altn [60] 62.1% [66] 2102(28.2%) 0(0.0%) errors ...erbie/ival-pow-test/src/points.rkt:190:0 for-loop [73] 64.9% temp85_0 [72] 18.0% eval-one-top12 [79] 9.1% loop [91] 8.0% ------------------------------------------------------------------------------------- for-loop [54] 34.2% atab-add-altn [60] 65.8% [67] 626(8.4%) 0(0.0%) override-at-pnts ...t/src/core/alt-table.rkt:129:0 for-loop [75] 100.0% ------------------------------------------------------------------------------------- egraph-add-exprs [62] 100.0% [68] 624(8.4%) 0(0.0%) ??? ...e/ival-pow-test/src/core/simplify.rkt:102:6 for-loop [76] 100.0% ------------------------------------------------------------------------------------- atab-add-altn [60] 100.0% [69] 344(4.6%) 344(4.6%) for-loop ...-pow-test/src/core/alt-table.rkt:110:2 ------------------------------------------------------------------------------------- atab-add-altn [60] 100.0% [70] 216(2.9%) 216(2.9%) loop ...-7.5/collects/racket/private/hash.rkt:20:4 ------------------------------------------------------------------------------------- rewriter [64] 100.0% [71] 158(2.1%) 0(0.0%) for-loop ...val-pow-test/src/core/matcher.rkt:89:4 matcher [80] 100.0% ------------------------------------------------------------------------------------- errors [66] 26.3% eval-const-expr [18] 73.7% [72] 1438(19.3%) 0(0.0%) temp85_0 (unknown source) compile15 [81] 100.0% ------------------------------------------------------------------------------------- errors [66] 100.0% [73] 1364(18.3%) 204(2.7%) for-loop ...bie/ival-pow-test/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [17] 85.0% ------------------------------------------------------------------------------------- location-do [74] 17.1% ??? [65] 82.9% [74] 1260(16.9%) 0(0.0%) location-do ...ival-pow-test/src/programs.rkt:63:0 ??? [65] 82.9% location-do [74] 17.1% ------------------------------------------------------------------------------------- override-at-pnts [67] 100.0% [75] 626(8.4%) 626(8.4%) for-loop ...pow-test/src/core/alt-table.rkt:130:22 ------------------------------------------------------------------------------------- ??? [68] 100.0% [76] 624(8.4%) 624(8.4%) for-loop ...l-pow-test/src/core/simplify.rkt:121:2 ------------------------------------------------------------------------------------- ??? [65] 100.0% [77] 440(5.9%) 240(3.2%) ival-mult ...al-pow-test/src/biginterval.rkt:125:0 bfmul [82] 45.5% ------------------------------------------------------------------------------------- ??? [65] 100.0% [78] 196(2.6%) 196(2.6%) successfully-got-the-right-kind-of-function ...5:4 ------------------------------------------------------------------------------------- errors [66] 100.0% [79] 192(2.6%) 192(2.6%) eval-one-top12 (unknown source) ------------------------------------------------------------------------------------- for-loop [13] 50.0% for-loop [71] 50.0% [80] 158(2.1%) 0(0.0%) matcher ...val-pow-test/src/core/matcher.rkt:115:2 ??? [6] 50.0% rewriter [64] 50.0% ------------------------------------------------------------------------------------- temp85_0 [72] 100.0% [81] 1438(19.3%) 0(0.0%) compile15 (unknown source) temp91_0 [83] 100.0% ------------------------------------------------------------------------------------- ival-mult [77] 100.0% [82] 200(2.7%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [84] 100.0% ------------------------------------------------------------------------------------- compile15 [81] 100.0% [83] 1438(19.3%) 0(0.0%) temp91_0 (unknown source) compile-top9 [85] 46.5% temp118_0 [86] 39.4% loop [91] 14.2% ------------------------------------------------------------------------------------- bfmul [82] 100.0% [84] 200(2.7%) 200(2.7%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ------------------------------------------------------------------------------------- temp91_0 [83] 100.0% [85] 668(9.0%) 0(0.0%) compile-top9 (unknown source) compile-forms33 [88] 66.2% hash->linklet-bundle [89] 33.8% ------------------------------------------------------------------------------------- temp91_0 [83] 100.0% [86] 566(7.6%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [87] 100.0% ------------------------------------------------------------------------------------- loop [91] 39.7% temp118_0 [86] 60.3% [87] 938(12.6%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [90] 60.3% loop [91] 21.7% expand-id-application-form17 [94] 17.9% ------------------------------------------------------------------------------------- compile-top9 [85] 100.0% [88] 442(5.9%) 0(0.0%) compile-forms33 (unknown source) for-loop [93] 100.0% ------------------------------------------------------------------------------------- compile-top9 [85] 100.0% [89] 226(3.0%) 226(3.0%) hash->linklet-bundle (unknown source) ------------------------------------------------------------------------------------- expand-capturing-lifts [87] 100.0% [90] 566(7.6%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [92] 67.1% loop [91] 32.9% ------------------------------------------------------------------------------------- egraph-add-exprs [62] 3.7% syntax-e/no-taint [100] 8.1% for-loop [93] 8.1% for-loop [34] 8.7% expand-capturing-lifts [87] 8.8% temp91_0 [83] 8.8% errors [66] 14.4% lambda-clause-expander [90] 16.0% loop [91] 23.5% [91] 1164(15.6%) 420(5.6%) loop (unknown source) expand-id-application-form17 [94] 24.1% loop [91] 23.5% expand-capturing-lifts [87] 23.2% ??? [95] 8.7% gf [96] 8.1% ------------------------------------------------------------------------------------- lambda-clause-expander [90] 29.3% for-loop [93] 70.7% [92] 380(5.1%) 0(0.0%) finish-bodys (unknown source) for-loop [93] 100.0% ------------------------------------------------------------------------------------- for-loop [93] 9.6% finish-bodys [92] 36.7% compile-forms33 [88] 53.8% [93] 822(11.0%) 0(0.0%) for-loop (unknown source) compile-module-linklet57 [97] 53.8% finish-bodys [92] 27.1% for-loop [93] 9.6% loop [91] 7.6% datum->syntax6 [98] 1.9% ------------------------------------------------------------------------------------- expand-capturing-lifts [87] 31.0% loop [91] 69.0% [94] 542(7.3%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [100] 34.7% resolve+shift28 [101] 34.3% binding-lookup52 [102] 31.0% ------------------------------------------------------------------------------------- loop [91] 100.0% [95] 202(2.7%) 202(2.7%) ??? .../herbie/ival-pow-test/src/points.rkt:179:26 ------------------------------------------------------------------------------------- loop [91] 100.0% [96] 188(2.5%) 0(0.0%) gf (unknown source) cache-or-reuse-set [99] 100.0% ------------------------------------------------------------------------------------- for-loop [93] 100.0% [97] 442(5.9%) 442(5.9%) compile-module-linklet57 (unknown source) ------------------------------------------------------------------------------------- for-loop [93] 100.0% [98] 192(2.6%) 192(2.6%) datum->syntax6 (unknown source) ------------------------------------------------------------------------------------- gf [96] 100.0% [99] 188(2.5%) 188(2.5%) cache-or-reuse-set (unknown source) ------------------------------------------------------------------------------------- expand-id-application-form17 [94] 100.0% [100] 188(2.5%) 0(0.0%) syntax-e/no-taint (unknown source) loop [91] 100.0% ------------------------------------------------------------------------------------- expand-id-application-form17 [94] 100.0% [101] 186(2.5%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [103] 100.0% ------------------------------------------------------------------------------------- expand-id-application-form17 [94] 100.0% [102] 168(2.3%) 168(2.3%) binding-lookup52 (unknown source) ------------------------------------------------------------------------------------- resolve+shift28 [101] 100.0% [103] 186(2.5%) 186(2.5%) fallback-loop (unknown source) -------------------------------------------------------------------------------------