Profiling results ----------------- Total cpu time observed: 6564ms (out of 6600ms) Number of samples taken: 33 (once every 199ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== [1] 6564(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [6] 100.0% ---------------------------------------------------------------------- ??? [68] 100.0% [2] 1288(19.6%) 0(0.0%) approximate9 ...faster-rr/src/core/taylor.rkt:11:0 for-loop [7] 53.4% loop [8] 46.6% ---------------------------------------------------------------------- hash-ref! [18] 100.0% [3] 200(3.0%) 0(0.0%) ??? ...herbie/faster-rr/src/core/taylor.rkt:290:26 for-loop [10] 100.0% ---------------------------------------------------------------------- hash-ref! [18] 100.0% [4] 200(3.0%) 0(0.0%) ??? ...herbie/faster-rr/src/core/taylor.rkt:300:23 for-loop [9] 100.0% ---------------------------------------------------------------------- for-loop [91] 100.0% [5] 194(3.0%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [11] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [6] 6564(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [12] 100.0% ---------------------------------------------------------------------- approximate9 [2] 100.0% [7] 688(10.5%) 0(0.0%) for-loop ...ie/faster-rr/src/core/taylor.rkt:29:18 taylor [24] 60.5% taylor-quotient [13] 39.5% ---------------------------------------------------------------------- approximate9 [2] 100.0% [8] 600(9.1%) 0(0.0%) loop .../herbie/faster-rr/src/core/taylor.rkt:86:4 hash-ref! [18] 100.0% ---------------------------------------------------------------------- ??? [4] 100.0% [9] 200(3.0%) 0(0.0%) for-loop ...e/faster-rr/src/core/taylor.rkt:303:27 hash-ref! [18] 100.0% ---------------------------------------------------------------------- ??? [3] 100.0% [10] 200(3.0%) 0(0.0%) for-loop ...e/faster-rr/src/core/taylor.rkt:290:52 hash-ref! [18] 100.0% ---------------------------------------------------------------------- syntax-e [5] 100.0% [11] 194(3.0%) 0(0.0%) syntax-e/no-taint (unknown source) loop [92] 100.0% ---------------------------------------------------------------------- profile-thunk16 [6] 100.0% [12] 6564(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [14] 100.0% ---------------------------------------------------------------------- for-loop [7] 100.0% [13] 272(4.1%) 0(0.0%) taylor-quotient ...er-rr/src/core/taylor.rkt:333:0 first-nonzero-exp [15] 100.0% ---------------------------------------------------------------------- for-loop [76] 7.5% run [12] 92.5% [14] 6564(100.0%) 584(8.9%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [16] 44.8% prepare-points-intervals [17] 29.1% get-final-combination [19] 6.1% oracle-error [20] 5.6% errors [72] 4.2% ??? [96] 3.0% loop [92] 2.8% ---------------------------------------------------------------------- taylor-quotient [13] 100.0% [15] 272(4.1%) 0(0.0%) first-nonzero-exp ...-rr/src/core/taylor.rkt:265:0 hash-ref! [18] 100.0% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [14] 100.0% [16] 3142(47.9%) 0(0.0%) run-improve47 .../faster-rr/src/mainloop.rkt:346:0 for-loop [21] 100.0% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [14] 100.0% [17] 1908(29.1%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:120:0 loop [22] 100.0% ---------------------------------------------------------------------- for-loop [10] 3.8% for-loop [9] 3.8% ??? [25] 3.8% ??? [27] 11.5% ??? [68] 22.9% loop [8] 22.9% first-nonzero-exp [15] 31.2% [18] 872(13.3%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop74 [23] 42.7% ??? [25] 26.7% ??? [27] 11.5% taylor [24] 11.4% ??? [4] 3.8% ??? [3] 3.8% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [14] 100.0% [19] 596(9.1%) 0(0.0%) get-final-combination ...rr/src/mainloop.rkt:371:0 infer-splitpoints [26] 100.0% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [14] 100.0% [20] 366(5.6%) 0(0.0%) oracle-error ...bie/faster-rr/src/points.rkt:177:0 for-loop [28] 100.0% ---------------------------------------------------------------------- run-improve47 [16] 100.0% [21] 3142(47.9%) 0(0.0%) for-loop ...erbie/faster-rr/src/mainloop.rkt:365:4 run-iter! [29] 100.0% ---------------------------------------------------------------------- prepare-points-intervals [17] 100.0% [22] 1908(29.1%) 184(2.8%) loop ...lies/herbie/faster-rr/src/points.rkt:132:4 loop [30] 69.2% ??? [33] 21.2% ---------------------------------------------------------------------- hash-ref! [18] 100.0% [23] 674(10.3%) 200(3.0%) parse-loop74 (unknown source) eval-const-expr [32] 70.3% ---------------------------------------------------------------------- hash-ref! [18] 8.1% map [35] 17.6% taylor [24] 24.2% for-loop [7] 50.2% [24] 614(9.4%) 398(6.1%) taylor ...rbie/faster-rr/src/core/taylor.rkt:169:0 taylor [24] 24.2% map [35] 17.6% debug-print [34] 17.6% ---------------------------------------------------------------------- hash-ref! [18] 100.0% [25] 600(9.1%) 0(0.0%) ??? .../herbie/faster-rr/src/core/taylor.rkt:67:15 ??? [68] 83.3% hash-ref! [18] 16.7% ---------------------------------------------------------------------- get-final-combination [19] 100.0% [26] 596(9.1%) 0(0.0%) infer-splitpoints ...-rr/src/core/regimes.rkt:33:0 for-loop [31] 100.0% ---------------------------------------------------------------------- hash-ref! [18] 100.0% [27] 402(6.1%) 0(0.0%) ??? .../herbie/faster-rr/src/core/taylor.rkt:44:15 hash-ref! [18] 100.0% ---------------------------------------------------------------------- oracle-error [20] 100.0% [28] 366(5.6%) 0(0.0%) for-loop .../herbie/faster-rr/src/points.rkt:178:2 ??? [36] 50.3% loop [92] 49.7% ---------------------------------------------------------------------- for-loop [21] 100.0% [29] 3142(47.9%) 0(0.0%) run-iter! ...rbie/faster-rr/src/mainloop.rkt:327:0 gen-series! [37] 41.0% finalize-iter! [38] 31.6% simplify! [39] 20.9% choose-best-alt! [43] 6.4% ---------------------------------------------------------------------- loop [22] 100.0% [30] 1320(20.1%) 370(5.6%) loop ...tlies/herbie/faster-rr/src/points.rkt:79:2 ??? [44] 15.2% real->precision [45] 14.8% ??? [68] 14.2% ...higher-order.rkt:375:33 [46] 13.9% ??? [48] 13.8% ---------------------------------------------------------------------- infer-splitpoints [26] 100.0% [31] 596(9.1%) 0(0.0%) for-loop ...ie/faster-rr/src/core/regimes.rkt:45:6 option-on-expr [40] 100.0% ---------------------------------------------------------------------- parse-loop74 [23] 100.0% [32] 474(7.2%) 0(0.0%) eval-const-expr ...aster-rr/src/programs.rkt:120:0 temp85_0 [77] 100.0% ---------------------------------------------------------------------- loop [22] 100.0% [33] 404(6.2%) 0(0.0%) ??? ...tlies/herbie/faster-rr/src/points.rkt:113:6 sample-multi-bounded [41] 100.0% ---------------------------------------------------------------------- taylor [24] 100.0% [34] 216(3.3%) 0(0.0%) debug-print ...erbie/faster-rr/src/debug.rkt:110:0 ??? [42] 100.0% ---------------------------------------------------------------------- taylor [24] 100.0% [35] 216(3.3%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 taylor [24] 100.0% ---------------------------------------------------------------------- for-loop [28] 100.0% [36] 184(2.8%) 184(2.8%) ??? ...7.5/collects/racket/private/for.rkt:1236:14 ---------------------------------------------------------------------- run-iter! [29] 100.0% [37] 1288(19.6%) 0(0.0%) gen-series! ...ie/faster-rr/src/mainloop.rkt:160:0 for-loop [47] 100.0% ---------------------------------------------------------------------- run-iter! [29] 100.0% [38] 994(15.1%) 0(0.0%) finalize-iter! ...faster-rr/src/mainloop.rkt:278:0 ??? [48] 100.0% ---------------------------------------------------------------------- run-iter! [29] 100.0% [39] 658(10.0%) 0(0.0%) simplify! ...rbie/faster-rr/src/mainloop.rkt:224:0 ??? [49] 100.0% ---------------------------------------------------------------------- for-loop [31] 100.0% [40] 596(9.1%) 0(0.0%) option-on-expr ...er-rr/src/core/regimes.rkt:124:0 for-loop [51] 66.4% err-lsts->split-indices [55] 33.6% ---------------------------------------------------------------------- ??? [33] 100.0% [41] 404(6.2%) 0(0.0%) sample-multi-bounded ...ter-rr/src/points.rkt:14:0 random-ranges [50] 100.0% ---------------------------------------------------------------------- debug-print [34] 100.0% [42] 216(3.3%) 0(0.0%) ??? .../contract/private/arrow-val-first.rkt:555:3 ~r92 [52] 100.0% ---------------------------------------------------------------------- run-iter! [29] 100.0% [43] 202(3.1%) 0(0.0%) choose-best-alt! ...ster-rr/src/mainloop.rkt:117:0 ...ow-val-first.rkt:486:18 [53] 100.0% ---------------------------------------------------------------------- loop [30] 100.0% [44] 200(3.0%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-add [54] 100.0% ---------------------------------------------------------------------- loop [30] 100.0% [45] 196(3.0%) 0(0.0%) real->precision ...aster-rr/src/programs.rkt:94:11 ??? [68] 100.0% ---------------------------------------------------------------------- loop [30] 100.0% [46] 184(2.8%) 0(0.0%) ...higher-order.rkt:375:33 (unknown source) loop [56] 100.0% ---------------------------------------------------------------------- gen-series! [37] 100.0% [47] 1288(19.6%) 0(0.0%) for-loop ...erbie/faster-rr/src/mainloop.rkt:167:7 taylor-alt [57] 100.0% ---------------------------------------------------------------------- loop [30] 15.5% finalize-iter! [38] 84.5% [48] 1176(17.9%) 182(2.8%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [58] 84.5% ---------------------------------------------------------------------- simplify! [39] 100.0% [49] 658(10.0%) 0(0.0%) ??? ...herbie/faster-rr/src/core/simplify.rkt:42:0 egraph-run [59] 100.0% ---------------------------------------------------------------------- sample-multi-bounded [41] 100.0% [50] 404(6.2%) 200(3.0%) random-ranges ...ie/faster-rr/src/common.rkt:164:0 build--> [60] 50.5% ---------------------------------------------------------------------- option-on-expr [40] 100.0% [51] 396(6.0%) 0(0.0%) for-loop ...e/faster-rr/src/core/regimes.rkt:135:4 errors [72] 100.0% ---------------------------------------------------------------------- ??? [42] 100.0% [52] 216(3.3%) 216(3.3%) ~r92 ...acket-7.5/collects/racket/format.rkt:189:0 ---------------------------------------------------------------------- choose-best-alt! [43] 100.0% [53] 202(3.1%) 0(0.0%) ...ow-val-first.rkt:486:18 (unknown source) ??? [61] 100.0% ---------------------------------------------------------------------- ??? [44] 100.0% [54] 200(3.0%) 0(0.0%) ival-add ...ie/faster-rr/src/biginterval.rkt:102:0 bfadd [78] 100.0% ---------------------------------------------------------------------- option-on-expr [40] 100.0% [55] 200(3.0%) 0(0.0%) err-lsts->split-indices .../core/regimes.rkt:263:0 loop [62] 100.0% ---------------------------------------------------------------------- ...higher-order.rkt:375:33 [46] 100.0% [56] 184(2.8%) 184(2.8%) loop ...herbie/faster-rr/src/biginterval.rkt:467:9 ---------------------------------------------------------------------- for-loop [47] 100.0% [57] 1288(19.6%) 0(0.0%) taylor-alt ...bie/faster-rr/src/mainloop.rkt:146:0 for-loop [63] 100.0% ---------------------------------------------------------------------- ??? [48] 100.0% [58] 994(15.1%) 0(0.0%) for-loop .../faster-rr/src/core/alt-table.rkt:46:2 atab-add-altn [65] 60.2% for-loop [70] 20.3% errors [72] 19.5% ---------------------------------------------------------------------- ??? [49] 100.0% [59] 658(10.0%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [64] 100.0% ---------------------------------------------------------------------- random-ranges [50] 100.0% [60] 204(3.1%) 204(3.1%) build--> ...act/private/arrow-val-first.rkt:1214:0 ---------------------------------------------------------------------- ...ow-val-first.rkt:486:18 [53] 100.0% [61] 202(3.1%) 0(0.0%) ??? ...erbie/faster-rr/src/core/alt-table.rkt:49:0 argmin [66] 100.0% ---------------------------------------------------------------------- err-lsts->split-indices [55] 100.0% [62] 200(3.0%) 0(0.0%) loop ...erbie/faster-rr/src/core/regimes.rkt:314:4 for-loop [67] 100.0% ---------------------------------------------------------------------- taylor-alt [57] 100.0% [63] 1288(19.6%) 0(0.0%) for-loop ...erbie/faster-rr/src/mainloop.rkt:152:6 ??? [68] 100.0% ---------------------------------------------------------------------- egraph-run [59] 100.0% [64] 658(10.0%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [69] 100.0% ---------------------------------------------------------------------- for-loop [58] 100.0% [65] 598(9.1%) 0(0.0%) atab-add-altn ...r-rr/src/core/alt-table.rkt:194:0 errors [72] 66.6% for-loop [70] 33.4% ---------------------------------------------------------------------- ??? [61] 100.0% [66] 202(3.1%) 0(0.0%) argmin ...acket-7.5/collects/racket/list.rkt:765:0 ??? [71] 100.0% ---------------------------------------------------------------------- loop [62] 100.0% [67] 200(3.0%) 200(3.0%) for-loop ...e/faster-rr/src/core/regimes.rkt:279:4 ---------------------------------------------------------------------- loop [30] 11.2% real->precision [45] 11.7% ??? [25] 12.0% location-do [73] 32.5% for-loop [63] 32.5% [68] 1672(25.5%) 196(3.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [73] 32.5% approximate9 [2] 32.5% hash-ref! [18] 12.0% ival-mult [75] 11.2% ---------------------------------------------------------------------- egraph-add-exprs [64] 100.0% [69] 658(10.0%) 0(0.0%) ??? ...erbie/faster-rr/src/core/simplify.rkt:102:6 for-loop [74] 100.0% ---------------------------------------------------------------------- atab-add-altn [65] 49.8% for-loop [58] 50.2% [70] 402(6.1%) 402(6.1%) for-loop ...faster-rr/src/core/alt-table.rkt:110:2 ---------------------------------------------------------------------- argmin [66] 100.0% [71] 202(3.1%) 0(0.0%) ??? ...es/herbie/faster-rr/src/mainloop.rkt:114:10 errors [72] 100.0% ---------------------------------------------------------------------- for-loop [58] 12.5% ??? [71] 13.0% .../more-scheme.rkt:261:28 [14] 23.6% for-loop [51] 25.4% atab-add-altn [65] 25.5% [72] 1558(23.7%) 0(0.0%) errors ...es/herbie/faster-rr/src/points.rkt:190:0 for-loop [76] 63.0% temp85_0 [77] 25.2% eval [79] 11.8% ---------------------------------------------------------------------- location-do [73] 18.1% ??? [68] 81.9% [73] 1288(19.6%) 0(0.0%) location-do ...bie/faster-rr/src/programs.rkt:63:0 ??? [68] 81.9% location-do [73] 18.1% ---------------------------------------------------------------------- ??? [69] 100.0% [74] 658(10.0%) 658(10.0%) for-loop .../faster-rr/src/core/simplify.rkt:121:2 ---------------------------------------------------------------------- ??? [68] 100.0% [75] 188(2.9%) 0(0.0%) ival-mult ...e/faster-rr/src/biginterval.rkt:120:0 bfadd [78] 100.0% ---------------------------------------------------------------------- errors [72] 100.0% [76] 982(15.0%) 0(0.0%) for-loop .../herbie/faster-rr/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [14] 100.0% ---------------------------------------------------------------------- errors [72] 45.3% eval-const-expr [32] 54.7% [77] 866(13.2%) 0(0.0%) temp85_0 (unknown source) compile15 [80] 100.0% ---------------------------------------------------------------------- ival-mult [75] 48.5% ival-add [54] 51.5% [78] 388(5.9%) 388(5.9%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ---------------------------------------------------------------------- errors [72] 100.0% [79] 184(2.8%) 0(0.0%) eval (unknown source) namespace-syntax-introduce3 [81]100.0% ---------------------------------------------------------------------- temp85_0 [77] 100.0% [80] 866(13.2%) 0(0.0%) compile15 (unknown source) temp91_0 [82] 100.0% ---------------------------------------------------------------------- eval [79] 100.0% [81] 184(2.8%) 0(0.0%) namespace-syntax-introduce3 (unknown source) free-identifier=? [83] 100.0% ---------------------------------------------------------------------- compile15 [80] 100.0% [82] 866(13.2%) 0(0.0%) temp91_0 (unknown source) temp118_0 [84] 76.7% compile-top9 [85] 23.3% ---------------------------------------------------------------------- namespace-syntax-introduce3 [81]100.0% [83] 184(2.8%) 0(0.0%) free-identifier=? (unknown source) resolve+shift28 [97] 100.0% ---------------------------------------------------------------------- temp91_0 [82] 100.0% [84] 664(10.1%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [86] 100.0% ---------------------------------------------------------------------- temp91_0 [82] 100.0% [85] 202(3.1%) 202(3.1%) compile-top9 (unknown source) ---------------------------------------------------------------------- loop [92] 21.7% temp118_0 [84] 78.3% [86] 848(12.9%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [87] 78.3% dispatch-transformer41 [88] 21.7% ---------------------------------------------------------------------- expand-capturing-lifts [86] 100.0% [87] 664(10.1%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [89] 100.0% ---------------------------------------------------------------------- expand-capturing-lifts [86] 100.0% [88] 184(2.8%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [90] 100.0% ---------------------------------------------------------------------- lambda-clause-expander [87] 19.4% for-loop [91] 80.6% [89] 664(10.1%) 0(0.0%) finish-bodys (unknown source) for-loop [91] 100.0% ---------------------------------------------------------------------- dispatch-transformer41 [88] 100.0% [90] 184(2.8%) 0(0.0%) apply-transformer52 (unknown source) loop [92] 100.0% ---------------------------------------------------------------------- for-loop [91] 21.2% finish-bodys [89] 78.8% [91] 664(10.1%) 272(4.1%) for-loop (unknown source) finish-bodys [89] 64.0% for-loop [91] 21.2% syntax-e [5] 4.9% expand-implicit [93] 1.7% ---------------------------------------------------------------------- apply-transformer52 [90] 11.0% loop [92] 11.0% .../more-scheme.rkt:261:28 [14] 11.0% for-loop [28] 32.5% syntax-e/no-taint [11] 34.6% [92] 560(8.5%) 194(3.0%) loop (unknown source) ??? [95] 32.5% loop [92] 11.0% expand-capturing-lifts [86] 11.0% core-form-sym [94] 11.0% ---------------------------------------------------------------------- for-loop [91] 100.0% [93] 198(3.0%) 0(0.0%) expand-implicit (unknown source) resolve+shift28 [97] 100.0% ---------------------------------------------------------------------- loop [92] 100.0% [94] 184(2.8%) 0(0.0%) core-form-sym (unknown source) resolve+shift28 [97] 100.0% ---------------------------------------------------------------------- loop [92] 100.0% [95] 182(2.8%) 0(0.0%) ??? ...lies/herbie/faster-rr/src/points.rkt:179:26 ??? [96] 100.0% ---------------------------------------------------------------------- ??? [95] 31.4% .../more-scheme.rkt:261:28 [14] 68.6% [96] 580(8.8%) 380(5.8%) ??? ...rbie/faster-rr/src/syntax/syntax.rkt:214:17 return/no-unsupplied [98] 34.5% ---------------------------------------------------------------------- core-form-sym [94] 32.5% free-identifier=? [83] 32.5% expand-implicit [93] 35.0% [97] 566(8.6%) 368(5.6%) resolve+shift28 (unknown source) apply-syntax-shifts [99] 35.0% ---------------------------------------------------------------------- ??? [96] 100.0% [98] 200(3.0%) 0(0.0%) return/no-unsupplied ...ct/private/arr-i.rkt:566:0 filter [100] 100.0% ---------------------------------------------------------------------- resolve+shift28 [97] 100.0% [99] 198(3.0%) 198(3.0%) apply-syntax-shifts (unknown source) ---------------------------------------------------------------------- return/no-unsupplied [98] 100.0% [100] 200(3.0%) 200(3.0%) filter ...5/collects/racket/private/list.rkt:256:2 ----------------------------------------------------------------------