Profiling results ----------------- Total cpu time observed: 4340ms (out of 4568ms) Number of samples taken: 22 (once every 197ms) ===================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ===================================================================== [1] 4340(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [6] 100.0% --------------------------------------------------------------------- ??? [82] 100.0% [2] 598(13.8%) 0(0.0%) approximate9 .../findroot/src/core/taylor.rkt:11:0 loop [8] 66.2% for-loop [9] 33.8% --------------------------------------------------------------------- for-loop [85] 100.0% [3] 244(5.6%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [7] 100.0% --------------------------------------------------------------------- loop [80] 100.0% [4] 202(4.7%) 0(0.0%) core-form-sym (unknown source) resolve+shift28 [7] 100.0% --------------------------------------------------------------------- hash-ref! [62] 100.0% [5] 154(3.5%) 0(0.0%) matcher ...bie/findroot/src/core/matcher.rkt:119:2 ??? [10] 50.0% rewriter [55] 50.0% --------------------------------------------------------------------- ??? [1] 100.0% [6] 4340(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [11] 100.0% --------------------------------------------------------------------- core-form-sym [4] 45.3% expand-identifier [3] 54.7% [7] 446(10.3%) 202(4.7%) resolve+shift28 (unknown source) fallback-loop [12] 54.7% --------------------------------------------------------------------- approximate9 [2] 100.0% [8] 396(9.1%) 0(0.0%) loop ...s/herbie/findroot/src/core/taylor.rkt:86:4 ??? [82] 100.0% --------------------------------------------------------------------- approximate9 [2] 100.0% [9] 202(4.7%) 0(0.0%) for-loop ...bie/findroot/src/core/taylor.rkt:29:18 taylor-quotient [13] 100.0% --------------------------------------------------------------------- matcher [5] 100.0% [10] 154(3.5%) 0(0.0%) ??? ...herbie/findroot/src/core/matcher.rkt:131:11 for-loop [14] 100.0% --------------------------------------------------------------------- profile-thunk16 [6] 100.0% [11] 4340(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [15]100.0% --------------------------------------------------------------------- resolve+shift28 [7] 100.0% [12] 244(5.6%) 0(0.0%) fallback-loop (unknown source) for-loop [85] 100.0% --------------------------------------------------------------------- for-loop [9] 100.0% [13] 202(4.7%) 0(0.0%) taylor-quotient ...droot/src/core/taylor.rkt:333:0 first-nonzero-exp [16] 100.0% --------------------------------------------------------------------- ??? [10] 100.0% [14] 154(3.5%) 0(0.0%) for-loop ...e/findroot/src/core/matcher.rkt:133:15 hash-ref! [62] 100.0% --------------------------------------------------------------------- for-loop [63] 2.1% run [11] 97.9% [15] 4340(100.0%) 186(4.3%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [17] 50.1% prepare-points-intervals [18] 27.4% oracle-error [19] 13.9% get-final-combination [20] 6.4% --------------------------------------------------------------------- taylor-quotient [13] 100.0% [16] 202(4.7%) 0(0.0%) first-nonzero-exp ...oot/src/core/taylor.rkt:265:0 hash-ref! [62] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15]100.0% [17] 2176(50.1%) 0(0.0%) run-improve47 ...e/findroot/src/mainloop.rkt:346:0 for-loop [21] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15]100.0% [18] 1190(27.4%) 0(0.0%) prepare-points-intervals ...t/src/points.rkt:120:0 loop [22] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15]100.0% [19] 604(13.9%) 0(0.0%) oracle-error ...rbie/findroot/src/points.rkt:177:0 for-loop [23] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15]100.0% [20] 370(8.5%) 0(0.0%) get-final-combination ...ot/src/mainloop.rkt:371:0 infer-splitpoints [24] 100.0% --------------------------------------------------------------------- run-improve47 [17] 100.0% [21] 2176(50.1%) 0(0.0%) for-loop ...herbie/findroot/src/mainloop.rkt:365:4 run-iter! [25] 100.0% --------------------------------------------------------------------- prepare-points-intervals [18] 100.0% [22] 1190(27.4%) 0(0.0%) loop ...tlies/herbie/findroot/src/points.rkt:132:4 loop [26] 51.6% ??? [27] 48.4% --------------------------------------------------------------------- oracle-error [19] 100.0% [23] 604(13.9%) 0(0.0%) for-loop ...s/herbie/findroot/src/points.rkt:178:2 loop [80] 66.9% map [69] 33.1% --------------------------------------------------------------------- get-final-combination [20] 100.0% [24] 370(8.5%) 0(0.0%) infer-splitpoints ...oot/src/core/regimes.rkt:33:0 for-loop [28] 100.0% --------------------------------------------------------------------- for-loop [21] 100.0% [25] 2176(50.1%) 0(0.0%) run-iter! ...erbie/findroot/src/mainloop.rkt:327:0 simplify! [29] 49.2% gen-series! [30] 27.5% finalize-iter! [34] 16.3% gen-rewrites! [35] 7.1% --------------------------------------------------------------------- loop [22] 100.0% [26] 614(14.1%) 0(0.0%) loop ...htlies/herbie/findroot/src/points.rkt:79:2 real->precision [32] 69.7% ??? [82] 30.3% --------------------------------------------------------------------- loop [22] 100.0% [27] 576(13.3%) 0(0.0%) ??? ...htlies/herbie/findroot/src/points.rkt:113:6 sample-multi-bounded [31] 100.0% --------------------------------------------------------------------- infer-splitpoints [24] 100.0% [28] 370(8.5%) 0(0.0%) for-loop ...bie/findroot/src/core/regimes.rkt:45:6 option-on-expr [33] 100.0% --------------------------------------------------------------------- run-iter! [25] 100.0% [29] 1070(24.7%) 0(0.0%) simplify! ...erbie/findroot/src/mainloop.rkt:224:0 ??? [36] 100.0% --------------------------------------------------------------------- run-iter! [25] 100.0% [30] 598(13.8%) 0(0.0%) gen-series! ...bie/findroot/src/mainloop.rkt:160:0 for-loop [37] 100.0% --------------------------------------------------------------------- ??? [27] 100.0% [31] 576(13.3%) 182(4.2%) sample-multi-bounded ...ndroot/src/points.rkt:14:0 random-ranges [38] 68.4% --------------------------------------------------------------------- loop [26] 100.0% [32] 428(9.9%) 0(0.0%) real->precision ...findroot/src/programs.rkt:94:11 ??? [82] 100.0% --------------------------------------------------------------------- for-loop [28] 100.0% [33] 370(8.5%) 0(0.0%) option-on-expr ...droot/src/core/regimes.rkt:124:0 for-loop [40] 50.3% sort-context-on-expr [41] 49.7% --------------------------------------------------------------------- run-iter! [25] 100.0% [34] 354(8.2%) 0(0.0%) finalize-iter! .../findroot/src/mainloop.rkt:278:0 ??? [39] 100.0% --------------------------------------------------------------------- run-iter! [25] 100.0% [35] 154(3.5%) 0(0.0%) gen-rewrites! ...e/findroot/src/mainloop.rkt:183:0 for-loop [42] 100.0% --------------------------------------------------------------------- simplify! [29] 100.0% [36] 1070(24.7%) 0(0.0%) ??? .../herbie/findroot/src/core/simplify.rkt:42:0 egraph-run [43] 100.0% --------------------------------------------------------------------- gen-series! [30] 100.0% [37] 598(13.8%) 0(0.0%) for-loop ...herbie/findroot/src/mainloop.rkt:167:7 taylor-alt [44] 100.0% --------------------------------------------------------------------- sample-multi-bounded [31] 100.0% [38] 394(9.1%) 0(0.0%) random-ranges ...bie/findroot/src/common.rkt:164:0 cons/c [46] 50.8% build--> [47] 49.2% --------------------------------------------------------------------- finalize-iter! [34] 100.0% [39] 354(8.2%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [45] 100.0% --------------------------------------------------------------------- option-on-expr [33] 100.0% [40] 186(4.3%) 0(0.0%) for-loop ...ie/findroot/src/core/regimes.rkt:135:4 errors [57] 100.0% --------------------------------------------------------------------- option-on-expr [33] 100.0% [41] 184(4.2%) 0(0.0%) sort-context-on-expr ...src/core/regimes.rkt:117:0 ??? [48] 100.0% --------------------------------------------------------------------- gen-rewrites! [35] 100.0% [42] 154(3.5%) 0(0.0%) for-loop ...erbie/findroot/src/mainloop.rkt:191:11 rewrite-expression-head24 [49] 100.0% --------------------------------------------------------------------- ??? [36] 100.0% [43] 1070(24.7%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [50] 100.0% --------------------------------------------------------------------- for-loop [37] 100.0% [44] 598(13.8%) 0(0.0%) taylor-alt ...rbie/findroot/src/mainloop.rkt:146:0 for-loop [51] 100.0% --------------------------------------------------------------------- ??? [39] 100.0% [45] 354(8.2%) 0(0.0%) for-loop ...e/findroot/src/core/alt-table.rkt:46:2 atab-add-altn [52] 100.0% --------------------------------------------------------------------- random-ranges [38] 100.0% [46] 200(4.6%) 0(0.0%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [53] 100.0% --------------------------------------------------------------------- random-ranges [38] 100.0% [47] 194(4.5%) 194(4.5%) build--> ...act/private/arrow-val-first.rkt:1214:0 --------------------------------------------------------------------- sort-context-on-expr [41] 100.0% [48] 184(4.2%) 0(0.0%) ??? ...-7.5/collects/racket/private/sort.rkt:369:3 generic-sort/key [54] 100.0% --------------------------------------------------------------------- for-loop [42] 100.0% [49] 154(3.5%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [55] 100.0% --------------------------------------------------------------------- egraph-run [43] 100.0% [50] 1070(24.7%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [56] 100.0% --------------------------------------------------------------------- taylor-alt [44] 100.0% [51] 598(13.8%) 0(0.0%) for-loop ...herbie/findroot/src/mainloop.rkt:152:6 ??? [82] 100.0% --------------------------------------------------------------------- for-loop [45] 100.0% [52] 354(8.2%) 0(0.0%) atab-add-altn ...root/src/core/alt-table.rkt:194:0 errors [57] 100.0% --------------------------------------------------------------------- cons/c [46] 100.0% [53] 200(4.6%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [58] 100.0% --------------------------------------------------------------------- ??? [48] 100.0% [54] 184(4.2%) 0(0.0%) generic-sort/key .../racket/private/sort.rkt:156:2 copying-mergesort [59] 100.0% --------------------------------------------------------------------- rewrite-expression-head24 [49] 33.3% matcher [5] 66.7% [55] 154(3.5%) 0(0.0%) rewriter ...bie/findroot/src/core/matcher.rkt:87:2 for-loop [60] 100.0% --------------------------------------------------------------------- egraph-add-exprs [50] 100.0% [56] 1070(24.7%) 0(0.0%) ??? ...herbie/findroot/src/core/simplify.rkt:102:6 for-loop [61] 100.0% --------------------------------------------------------------------- for-loop [40] 34.4% atab-add-altn [52] 65.6% [57] 540(12.4%) 0(0.0%) errors ...ies/herbie/findroot/src/points.rkt:190:0 for-loop [63] 66.7% temp85_0 [73] 33.3% --------------------------------------------------------------------- coerce-contract [53] 100.0% [58] 200(4.6%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [64] 100.0% --------------------------------------------------------------------- generic-sort/key [54] 25.0% copying-mergesort [59] 75.0% [59] 184(4.2%) 0(0.0%) copying-mergesort ...racket/private/sort.rkt:129:8 copying-mergesort [59] 75.0% jloop [65] 25.0% --------------------------------------------------------------------- rewriter [55] 100.0% [60] 154(3.5%) 0(0.0%) for-loop ...bie/findroot/src/core/matcher.rkt:89:4 hash-ref! [62] 100.0% --------------------------------------------------------------------- ??? [56] 100.0% [61] 1070(24.7%) 1070(24.7%) for-loop ...e/findroot/src/core/simplify.rkt:121:2 --------------------------------------------------------------------- ??? [68] 6.7% for-loop [14] 8.2% for-loop [60] 12.3% ??? [66] 23.0% ??? [82] 23.0% first-nonzero-exp [16] 26.9% [62] 752(17.3%) 154(3.5%) hash-ref! .../racket/private/more-scheme.rkt:376:2 f40 [67] 26.9% ??? [66] 23.0% parse-loop74 [70] 23.0% matcher [5] 16.4% ??? [68] 6.7% --------------------------------------------------------------------- errors [57] 100.0% [63] 360(8.3%) 174(4.0%) for-loop ...s/herbie/findroot/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [15] 51.7% --------------------------------------------------------------------- coerce-contract/f [58] 100.0% [64] 200(4.6%) 200(4.6%) coerce-simple-value ...ract/private/guts.rkt:385:0 --------------------------------------------------------------------- copying-mergesort [59] 100.0% [65] 184(4.2%) 184(4.2%) jloop ...5/collects/racket/private/sort.rkt:120:23 --------------------------------------------------------------------- hash-ref! [62] 100.0% [66] 396(9.1%) 0(0.0%) ??? ...s/herbie/findroot/src/core/taylor.rkt:44:15 hash-ref! [62] 100.0% --------------------------------------------------------------------- hash-ref! [62] 100.0% [67] 202(4.7%) 0(0.0%) f40 (unknown source) map [69] 100.0% --------------------------------------------------------------------- hash-ref! [62] 100.0% [68] 152(3.5%) 0(0.0%) ??? .../herbie/findroot/src/core/taylor.rkt:343:33 hash-ref! [62] 100.0% --------------------------------------------------------------------- for-loop [23] 49.8% f40 [67] 50.2% [69] 402(9.3%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 parse-loop74 [70] 50.2% loop [71] 49.8% --------------------------------------------------------------------- map [69] 33.8% hash-ref! [62] 66.2% [70] 598(13.8%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [72] 100.0% --------------------------------------------------------------------- map [69] 100.0% [71] 200(4.6%) 0(0.0%) loop ...-7.5/collects/racket/private/map.rkt:40:19 ??? [83] 100.0% --------------------------------------------------------------------- parse-loop74 [70] 100.0% [72] 598(13.8%) 0(0.0%) eval-const-expr ...findroot/src/programs.rkt:120:0 temp85_0 [73] 74.6% eval-one-top12 [74] 25.4% --------------------------------------------------------------------- errors [57] 28.8% eval-const-expr [72] 71.2% [73] 626(14.4%) 0(0.0%) temp85_0 (unknown source) compile15 [75] 100.0% --------------------------------------------------------------------- eval-const-expr [72] 100.0% [74] 152(3.5%) 152(3.5%) eval-one-top12 (unknown source) --------------------------------------------------------------------- temp85_0 [73] 100.0% [75] 626(14.4%) 0(0.0%) compile15 (unknown source) temp91_0 [76] 100.0% --------------------------------------------------------------------- compile15 [75] 100.0% [76] 626(14.4%) 0(0.0%) temp91_0 (unknown source) temp118_0 [77] 100.0% --------------------------------------------------------------------- temp91_0 [76] 100.0% [77] 626(14.4%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [78] 100.0% --------------------------------------------------------------------- temp118_0 [77] 100.0% [78] 626(14.4%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [79] 100.0% --------------------------------------------------------------------- expand-capturing-lifts [78] 100.0% [79] 626(14.4%) 0(0.0%) lambda-clause-expander (unknown source) loop [80] 61.0% finish-bodys [81] 39.0% --------------------------------------------------------------------- apply-transformer52 [87] 12.8% lambda-clause-expander [79] 35.8% for-loop [23] 51.4% [80] 786(18.1%) 0(0.0%) loop (unknown source) dispatch-transformer41 [84] 35.8% ??? [83] 27.0% ??? [82] 24.4% core-form-sym [4] 12.8% --------------------------------------------------------------------- lambda-clause-expander [79] 11.1% for-loop [85] 88.9% [81] 244(5.6%) 0(0.0%) finish-bodys (unknown source) for-loop [85] 100.0% --------------------------------------------------------------------- loop [8] 9.4% loop [26] 13.2% loop [80] 13.7% location-do [86] 16.6% for-loop [51] 16.6% real->precision [32] 30.5% [82] 1404(32.4%) 398(9.2%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [86] 16.6% approximate9 [2] 16.6% bf [88] 15.8% ival-mult [90] 13.2% hash-ref! [62] 9.4% --------------------------------------------------------------------- loop [71] 48.5% loop [80] 51.5% [83] 412(9.5%) 200(4.6%) ??? ...tlies/herbie/findroot/src/points.rkt:179:26 ulp-difference [89] 51.5% --------------------------------------------------------------------- loop [80] 100.0% [84] 382(8.8%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [87] 100.0% --------------------------------------------------------------------- fallback-loop [12] 7.7% for-loop [85] 23.1% finish-bodys [81] 69.2% [85] 244(5.6%) 244(5.6%) for-loop (unknown source) finish-bodys [81] 61.5% for-loop [85] 23.1% expand-identifier [3] 7.7% --------------------------------------------------------------------- ??? [82] 43.2% location-do [86] 56.8% [86] 598(13.8%) 0(0.0%) location-do ...rbie/findroot/src/programs.rkt:63:0 location-do [86] 56.8% ??? [82] 43.2% --------------------------------------------------------------------- dispatch-transformer41 [84] 100.0% [87] 382(8.8%) 180(4.1%) apply-transformer52 (unknown source) loop [80] 52.9% --------------------------------------------------------------------- ??? [82] 100.0% [88] 222(5.1%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [91] 100.0% --------------------------------------------------------------------- ??? [83] 100.0% [89] 212(4.9%) 212(4.9%) ulp-difference ...rbie/findroot/src/float.rkt:19:0 --------------------------------------------------------------------- ??? [82] 100.0% [90] 186(4.3%) 186(4.3%) ival-mult ...ie/findroot/src/biginterval.rkt:129:0 --------------------------------------------------------------------- bf [88] 100.0% [91] 222(5.1%) 222(5.1%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ---------------------------------------------------------------------