Profiling results ----------------- Total cpu time observed: 6558ms (out of 6656ms) Number of samples taken: 31 (once every 212ms) ==================================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ==================================================================================== [1] 6558(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [4] 100.0% ------------------------------------------------------------------------------------ loop [61] 100.0% [2] 200(3.0%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [6] 100.0% ------------------------------------------------------------------------------------ loop [61] 100.0% [3] 200(3.0%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [5] 100.0% ------------------------------------------------------------------------------------ ??? [1] 100.0% [4] 6558(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [7] 100.0% ------------------------------------------------------------------------------------ dispatch-transformer41 [3] 100.0% [5] 200(3.0%) 0(0.0%) apply-transformer52 (unknown source) loop [61] 100.0% ------------------------------------------------------------------------------------ syntax-e [2] 100.0% [6] 200(3.0%) 0(0.0%) syntax-e/no-taint (unknown source) loop [61] 100.0% ------------------------------------------------------------------------------------ profile-thunk16 [4] 100.0% [7] 6558(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [8] 100.0% ------------------------------------------------------------------------------------ for-loop [46] 1.6% run [7] 98.4% [8] 6558(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [9] 73.6% run-improve47 [10] 17.0% errors [44] 4.6% oracle-error [12] 3.2% ??? [11] 1.6% ------------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [8] 100.0% [9] 4826(73.6%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:133:0 loop [13] 100.0% ------------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [8] 100.0% [10] 1116(17.0%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:365:0 for-loop [14] 100.0% ------------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [8] 100.0% [11] 208(3.2%) 208(3.2%) ??? ...cket-7.5/collects/racket/function.rkt:93:12 ------------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [8] 100.0% [12] 208(3.2%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:190:0 for-loop [15] 100.0% ------------------------------------------------------------------------------------ prepare-points-intervals [9] 100.0% [13] 4826(73.6%) 602(9.2%) loop ...ghtlies/herbie/master/src/points.rkt:145:4 loop [16] 66.6% ??? [18] 16.7% do-curry [19] 4.2% ------------------------------------------------------------------------------------ run-improve47 [10] 100.0% [14] 1116(17.0%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:384:4 run-iter! [17] 100.0% ------------------------------------------------------------------------------------ oracle-error [12] 100.0% [15] 208(3.2%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:191:2 loop [61] 100.0% ------------------------------------------------------------------------------------ loop [13] 100.0% [16] 3214(49.0%) 200(3.0%) loop ...ightlies/herbie/master/src/points.rkt:81:2 ??? [63] 62.5% real->precision [22] 12.5% ??? [23] 12.4% hash-update! [25] 6.3% ------------------------------------------------------------------------------------ for-loop [14] 100.0% [17] 1116(17.0%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:346:0 simplify! [21] 63.8% gen-rewrites! [24] 18.3% finalize-iter! [26] 17.9% ------------------------------------------------------------------------------------ loop [13] 100.0% [18] 808(12.3%) 0(0.0%) ??? ...ightlies/herbie/master/src/points.rkt:126:6 sample-multi-bounded [20] 100.0% ------------------------------------------------------------------------------------ loop [13] 100.0% [19] 202(3.1%) 202(3.1%) do-curry ...-7.5/collects/racket/function.rkt:71:2 ------------------------------------------------------------------------------------ ??? [18] 100.0% [20] 808(12.3%) 200(3.0%) sample-multi-bounded ...master/src/points.rkt:14:0 random-ranges [28] 75.2% ------------------------------------------------------------------------------------ run-iter! [17] 100.0% [21] 712(10.9%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:224:0 ??? [27] 100.0% ------------------------------------------------------------------------------------ loop [16] 100.0% [22] 402(6.1%) 0(0.0%) real->precision .../master/src/programs.rkt:118:11 ??? [30] 50.2% ??? [63] 49.8% ------------------------------------------------------------------------------------ loop [16] 100.0% [23] 400(6.1%) 200(3.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-sub [31] 50.0% ------------------------------------------------------------------------------------ run-iter! [17] 100.0% [24] 204(3.1%) 0(0.0%) gen-rewrites! ...bie/master/src/mainloop.rkt:183:0 for-loop [29] 100.0% ------------------------------------------------------------------------------------ loop [16] 100.0% [25] 202(3.1%) 202(3.1%) hash-update! ...cket/private/more-scheme.rkt:365:4 ------------------------------------------------------------------------------------ run-iter! [17] 100.0% [26] 200(3.0%) 0(0.0%) finalize-iter! ...ie/master/src/mainloop.rkt:278:0 ??? [32] 100.0% ------------------------------------------------------------------------------------ simplify! [21] 100.0% [27] 712(10.9%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:42:0 egraph-run [33] 100.0% ------------------------------------------------------------------------------------ sample-multi-bounded [20] 100.0% [28] 608(9.3%) 406(6.2%) random-ranges ...erbie/master/src/common.rkt:164:0 cons/c [36] 33.2% ------------------------------------------------------------------------------------ gen-rewrites! [24] 100.0% [29] 204(3.1%) 0(0.0%) for-loop .../herbie/master/src/mainloop.rkt:191:11 rewrite-expression-head23 [34] 100.0% ------------------------------------------------------------------------------------ real->precision [22] 100.0% [30] 202(3.1%) 0(0.0%) ??? ...ects/racket/contract/private/guts.rkt:770:8 bigvalue? [35] 100.0% ------------------------------------------------------------------------------------ ??? [23] 100.0% [31] 200(3.0%) 0(0.0%) ival-sub ...erbie/master/src/biginterval.rkt:195:0 eplinear [37] 100.0% ------------------------------------------------------------------------------------ finalize-iter! [26] 100.0% [32] 200(3.0%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [38] 100.0% ------------------------------------------------------------------------------------ ??? [27] 100.0% [33] 712(10.9%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [39] 100.0% ------------------------------------------------------------------------------------ for-loop [29] 100.0% [34] 204(3.1%) 0(0.0%) rewrite-expression-head23 ...core/matcher.rkt:83:0 rewriter [40] 100.0% ------------------------------------------------------------------------------------ ??? [30] 100.0% [35] 202(3.1%) 202(3.1%) bigvalue? ...rbie/master/src/syntax/types.rkt:19:0 ------------------------------------------------------------------------------------ random-ranges [28] 100.0% [36] 202(3.1%) 0(0.0%) cons/c .../racket/contract/private/guts.rkt:500:15 flat-contract? [41] 100.0% ------------------------------------------------------------------------------------ ival-sub [31] 100.0% [37] 200(3.0%) 0(0.0%) eplinear ...erbie/master/src/biginterval.rkt:182:0 bfmax2 [75] 100.0% ------------------------------------------------------------------------------------ ??? [32] 100.0% [38] 200(3.0%) 0(0.0%) for-loop ...ie/master/src/core/alt-table.rkt:201:2 atab-add-altn [42] 100.0% ------------------------------------------------------------------------------------ egraph-run [33] 100.0% [39] 712(10.9%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [43] 100.0% ------------------------------------------------------------------------------------ rewrite-expression-head23 [34] 100.0% [40] 204(3.1%) 0(0.0%) rewriter ...erbie/master/src/core/matcher.rkt:85:2 for-loop [45] 100.0% ------------------------------------------------------------------------------------ cons/c [36] 100.0% [41] 202(3.1%) 202(3.1%) flat-contract? .../contract/private/guts.rkt:129:0 ------------------------------------------------------------------------------------ for-loop [38] 100.0% [42] 200(3.0%) 0(0.0%) atab-add-altn ...ster/src/core/alt-table.rkt:204:0 errors [44] 100.0% ------------------------------------------------------------------------------------ egraph-add-exprs [39] 100.0% [43] 712(10.9%) 0(0.0%) ??? ...s/herbie/master/src/core/simplify.rkt:103:6 egg-run-rules [47] 50.3% for-loop [48] 49.7% ------------------------------------------------------------------------------------ atab-add-altn [42] 32.9% .../more-scheme.rkt:261:28 [8] 67.1% [44] 608(9.3%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:203:0 for-loop [46] 67.1% temp85_0 [50] 32.9% ------------------------------------------------------------------------------------ rewriter [40] 100.0% [45] 204(3.1%) 0(0.0%) for-loop ...erbie/master/src/core/matcher.rkt:87:4 hash-ref! [49] 100.0% ------------------------------------------------------------------------------------ errors [44] 100.0% [46] 408(6.2%) 200(3.0%) for-loop ...ies/herbie/master/src/points.rkt:205:2 .../more-scheme.rkt:261:28 [8] 51.0% ------------------------------------------------------------------------------------ ??? [43] 100.0% [47] 358(5.5%) 358(5.5%) egg-run-rules ...aster/src/core/simplify.rkt:109:0 ------------------------------------------------------------------------------------ ??? [43] 100.0% [48] 354(5.4%) 354(5.4%) for-loop ...bie/master/src/core/simplify.rkt:121:2 ------------------------------------------------------------------------------------ for-loop [45] 100.0% [49] 204(3.1%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 matcher [51] 100.0% ------------------------------------------------------------------------------------ errors [44] 100.0% [50] 200(3.0%) 0(0.0%) temp85_0 (unknown source) compile15 [52] 100.0% ------------------------------------------------------------------------------------ hash-ref! [49] 100.0% [51] 204(3.1%) 0(0.0%) matcher ...erbie/master/src/core/matcher.rkt:117:2 ??? [53] 100.0% ------------------------------------------------------------------------------------ temp85_0 [50] 100.0% [52] 200(3.0%) 0(0.0%) compile15 (unknown source) temp91_0 [54] 100.0% ------------------------------------------------------------------------------------ matcher [51] 100.0% [53] 204(3.1%) 0(0.0%) ??? ...s/herbie/master/src/core/matcher.rkt:129:11 for-loop [55] 100.0% ------------------------------------------------------------------------------------ compile15 [52] 100.0% [54] 200(3.0%) 0(0.0%) temp91_0 (unknown source) temp118_0 [56] 100.0% ------------------------------------------------------------------------------------ ??? [53] 100.0% [55] 204(3.1%) 0(0.0%) for-loop ...rbie/master/src/core/matcher.rkt:101:4 foldl [57] 100.0% ------------------------------------------------------------------------------------ temp91_0 [54] 100.0% [56] 200(3.0%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [58] 100.0% ------------------------------------------------------------------------------------ for-loop [55] 100.0% [57] 204(3.1%) 0(0.0%) foldl ....5/collects/racket/private/list.rkt:229:4 ??? [59] 100.0% ------------------------------------------------------------------------------------ temp118_0 [56] 100.0% [58] 200(3.0%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [60] 100.0% ------------------------------------------------------------------------------------ foldl [57] 100.0% [59] 204(3.1%) 0(0.0%) ??? ...ies/herbie/master/src/core/matcher.rkt:25:7 core457 [62] 100.0% ------------------------------------------------------------------------------------ expand-capturing-lifts [58] 100.0% [60] 200(3.0%) 0(0.0%) lambda-clause-expander (unknown source) loop [61] 100.0% ------------------------------------------------------------------------------------ loop [61] 12.3% syntax-e/no-taint [6] 12.3% apply-transformer52 [5] 12.3% lambda-clause-expander [60] 12.3% for-loop [15] 51.0% [61] 408(6.2%) 0(0.0%) loop (unknown source) ??? [63] 51.0% dispatch-transformer41 [3] 12.3% syntax-e [2] 12.3% loop [61] 12.3% gf [65] 12.3% ------------------------------------------------------------------------------------ ??? [59] 100.0% [62] 204(3.1%) 0(0.0%) core457 ...acket/contract/private/arr-i.rkt:976:19 successfully-got-the-right-kind-of-function [64]100.0% ------------------------------------------------------------------------------------ real->precision [22] 8.3% loop [61] 8.6% loop [16] 83.1% [63] 2418(36.9%) 208(3.2%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ??? [66] 33.5% ival-div [67] 33.1% composed [68] 16.5% bf [70] 8.3% ------------------------------------------------------------------------------------ core457 [62] 100.0% [64] 204(3.1%) 204(3.1%) successfully-got-the-right-kind-of-function ...5:4 ------------------------------------------------------------------------------------ loop [61] 100.0% [65] 200(3.0%) 0(0.0%) gf (unknown source) propagation-merge [69] 100.0% ------------------------------------------------------------------------------------ ??? [63] 100.0% [66] 810(12.4%) 0(0.0%) ??? ...ies/herbie/master/src/biginterval.rkt:277:0 epfn [71] 100.0% ------------------------------------------------------------------------------------ ??? [63] 100.0% [67] 800(12.2%) 600(9.1%) ival-div ...erbie/master/src/biginterval.rkt:250:0 epdiv [74] 25.0% ------------------------------------------------------------------------------------ ??? [63] 100.0% [68] 400(6.1%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 ??? [72] 100.0% ------------------------------------------------------------------------------------ gf [65] 100.0% [69] 200(3.0%) 200(3.0%) propagation-merge (unknown source) ------------------------------------------------------------------------------------ ??? [63] 100.0% [70] 200(3.0%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 ??? [73] 100.0% ------------------------------------------------------------------------------------ ??? [66] 100.0% [71] 810(12.4%) 612(9.3%) epfn ...es/herbie/master/src/biginterval.rkt:153:0 bflog [76] 24.4% ------------------------------------------------------------------------------------ composed [68] 100.0% [72] 400(6.1%) 200(3.0%) ??? ...ies/herbie/master/src/biginterval.rkt:285:0 bfmax2 [75] 50.0% ------------------------------------------------------------------------------------ bf [70] 100.0% [73] 200(3.0%) 200(3.0%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ------------------------------------------------------------------------------------ ival-div [67] 100.0% [74] 200(3.0%) 0(0.0%) epdiv ...s/herbie/master/src/biginterval.rkt:239:0 bfmax2 [75] 100.0% ------------------------------------------------------------------------------------ ??? [72] 33.3% epdiv [74] 33.3% eplinear [37] 33.3% [75] 600(9.1%) 400(6.1%) bfmax2 ...lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [77] 33.3% ------------------------------------------------------------------------------------ epfn [71] 100.0% [76] 198(3.0%) 0(0.0%) bflog ...-lib/math/private/bigfloat/mpfr.rkt:632:4 new-mpfr [77] 100.0% ------------------------------------------------------------------------------------ bflog [76] 49.7% bfmax2 [75] 50.3% [77] 398(6.1%) 398(6.1%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ------------------------------------------------------------------------------------