Profiling results ----------------- Total cpu time observed: 16406ms (out of 16640ms) Number of samples taken: 79 (once every 208ms) =============================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee =============================================================================== [1] 16406(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 100.0% ------------------------------------------------------------------------------- hash-ref! [59] 100.0% [2] 210(1.3%) 0(0.0%) matcher ...ie/better-rr/src/core/matcher.rkt:118:2 ??? [4] 50.0% rewriter [45] 50.0% ------------------------------------------------------------------------------- ??? [1] 100.0% [3] 16406(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% ------------------------------------------------------------------------------- matcher [2] 100.0% [4] 210(1.3%) 0(0.0%) ??? ...erbie/better-rr/src/core/matcher.rkt:130:11 for-loop [6] 100.0% ------------------------------------------------------------------------------- profile-thunk16 [3] 100.0% [5] 16406(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [7] 100.0% ------------------------------------------------------------------------------- ??? [4] 100.0% [6] 210(1.3%) 0(0.0%) for-loop .../better-rr/src/core/matcher.rkt:132:15 hash-ref! [59] 100.0% ------------------------------------------------------------------------------- for-loop [16] 0.6% run [5] 99.4% [7] 16406(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [12] 89.1% run-improve47 [8] 7.3% eval-errors [9] 1.2% oracle-error [10] 1.1% errors [11] 0.6% ??? [23] 0.6% ------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [7] 100.0% [8] 1204(7.3%) 0(0.0%) run-improve47 .../better-rr/src/mainloop.rkt:364:0 for-loop [13] 61.5% prepare-points-intervals [12] 19.9% simplify! [22] 18.6% ------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [7] 100.0% [9] 204(1.2%) 0(0.0%) eval-errors ...rbie/better-rr/src/points.rkt:170:0 for-loop [14] 100.0% ------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [7] 100.0% [10] 188(1.1%) 0(0.0%) oracle-error ...bie/better-rr/src/points.rkt:179:0 for-loop [15] 100.0% ------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [7] 100.0% [11] 188(1.1%) 0(0.0%) errors ...es/herbie/better-rr/src/points.rkt:192:0 for-loop [16] 100.0% ------------------------------------------------------------------------------- run-improve47 [8] 1.6% .../more-scheme.rkt:261:28 [7] 98.4% [12] 14862(90.6%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:122:0 loop [17] 100.0% ------------------------------------------------------------------------------- run-improve47 [8] 100.0% [13] 740(4.5%) 0(0.0%) for-loop ...erbie/better-rr/src/mainloop.rkt:383:4 run-iter! [18] 100.0% ------------------------------------------------------------------------------- eval-errors [9] 100.0% [14] 204(1.2%) 204(1.2%) for-loop .../herbie/better-rr/src/points.rkt:172:2 ------------------------------------------------------------------------------- oracle-error [10] 100.0% [15] 188(1.1%) 0(0.0%) for-loop .../herbie/better-rr/src/points.rkt:180:2 loop [19] 100.0% ------------------------------------------------------------------------------- errors [11] 100.0% [16] 188(1.1%) 0(0.0%) for-loop .../herbie/better-rr/src/points.rkt:194:2 .../more-scheme.rkt:261:28 [7] 100.0% ------------------------------------------------------------------------------- prepare-points-intervals [12] 100.0% [17] 14862(90.6%) 208(1.3%) loop ...lies/herbie/better-rr/src/points.rkt:134:4 loop [20] 93.4% ??? [21] 5.2% ------------------------------------------------------------------------------- for-loop [13] 100.0% [18] 740(4.5%) 0(0.0%) run-iter! ...rbie/better-rr/src/mainloop.rkt:345:0 gen-series! [24] 36.2% simplify! [22] 35.4% gen-rewrites! [25] 28.4% ------------------------------------------------------------------------------- for-loop [15] 100.0% [19] 188(1.1%) 0(0.0%) loop (unknown source) ??? [23] 100.0% ------------------------------------------------------------------------------- loop [17] 100.0% [20] 13884(84.6%) 1174(7.2%) loop ...tlies/herbie/better-rr/src/points.rkt:79:2 ??? [49] 58.6% ??? [26] 22.9% real->precision [27] 4.4% log! [30] 2.8% ??? [31] 2.8% ------------------------------------------------------------------------------- loop [17] 100.0% [21] 770(4.7%) 0(0.0%) ??? ...tlies/herbie/better-rr/src/points.rkt:115:6 sample-multi-bounded [28] 75.1% ??? [49] 24.9% ------------------------------------------------------------------------------- run-improve47 [8] 46.1% run-iter! [18] 53.9% [22] 486(3.0%) 0(0.0%) simplify! ...rbie/better-rr/src/mainloop.rkt:223:0 ??? [29] 100.0% ------------------------------------------------------------------------------- loop [19] 50.0% .../more-scheme.rkt:261:28 [7] 50.0% [23] 376(2.3%) 376(2.3%) ??? ...rbie/better-rr/src/syntax/syntax.rkt:214:17 ------------------------------------------------------------------------------- run-iter! [18] 100.0% [24] 268(1.6%) 0(0.0%) gen-series! ...ie/better-rr/src/mainloop.rkt:159:0 for-loop [32] 100.0% ------------------------------------------------------------------------------- run-iter! [18] 100.0% [25] 210(1.3%) 0(0.0%) gen-rewrites! .../better-rr/src/mainloop.rkt:182:0 for-loop [33] 100.0% ------------------------------------------------------------------------------- loop [20] 100.0% [26] 3184(19.4%) 1482(9.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-sinh [34] 26.8% ival-sub [35] 26.7% ------------------------------------------------------------------------------- loop [20] 100.0% [27] 612(3.7%) 0(0.0%) real->precision ...tter-rr/src/programs.rkt:118:11 ??? [49] 100.0% ------------------------------------------------------------------------------- ??? [21] 100.0% [28] 578(3.5%) 0(0.0%) sample-multi-bounded ...ter-rr/src/points.rkt:14:0 random-ranges [37] 67.1% for-loop [41] 32.9% ------------------------------------------------------------------------------- simplify! [22] 100.0% [29] 486(3.0%) 0(0.0%) ??? ...herbie/better-rr/src/core/simplify.rkt:42:0 egraph-run [36] 100.0% ------------------------------------------------------------------------------- loop [20] 100.0% [30] 386(2.4%) 0(0.0%) log! ...tlies/herbie/better-rr/src/points.rkt:59:2 for-loop [38] 100.0% ------------------------------------------------------------------------------- loop [20] 100.0% [31] 386(2.4%) 200(1.2%) ??? ...contract/private/arrow-val-first.rkt:486:18 ??? [42] 48.2% ------------------------------------------------------------------------------- gen-series! [24] 100.0% [32] 268(1.6%) 0(0.0%) for-loop ...erbie/better-rr/src/mainloop.rkt:166:7 taylor-alt [39] 100.0% ------------------------------------------------------------------------------- gen-rewrites! [25] 100.0% [33] 210(1.3%) 0(0.0%) for-loop ...rbie/better-rr/src/mainloop.rkt:190:11 rewrite-expression-head23 [40] 100.0% ------------------------------------------------------------------------------- ??? [26] 100.0% [34] 852(5.2%) 0(0.0%) ival-sinh ...e/better-rr/src/biginterval.rkt:390:0 bfsinh [65] 100.0% ------------------------------------------------------------------------------- ??? [26] 100.0% [35] 850(5.2%) 188(1.1%) ival-sub ...ie/better-rr/src/biginterval.rkt:117:0 bfsub [64] 77.9% ------------------------------------------------------------------------------- ??? [29] 100.0% [36] 486(3.0%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [43] 100.0% ------------------------------------------------------------------------------- sample-multi-bounded [28] 100.0% [37] 388(2.4%) 0(0.0%) random-ranges ...ie/better-rr/src/common.rkt:164:0 cons/c [46] 52.1% build--> [47] 47.9% ------------------------------------------------------------------------------- log! [30] 100.0% [38] 386(2.4%) 386(2.4%) for-loop .../herbie/better-rr/src/points.rkt:66:23 ------------------------------------------------------------------------------- for-loop [32] 100.0% [39] 268(1.6%) 0(0.0%) taylor-alt ...bie/better-rr/src/mainloop.rkt:145:0 for-loop [44] 100.0% ------------------------------------------------------------------------------- for-loop [33] 100.0% [40] 210(1.3%) 0(0.0%) rewrite-expression-head23 ...core/matcher.rkt:83:0 rewriter [45] 100.0% ------------------------------------------------------------------------------- sample-multi-bounded [28] 100.0% [41] 190(1.2%) 190(1.2%) for-loop ...s/herbie/better-rr/src/points.rkt:20:4 ------------------------------------------------------------------------------- ??? [31] 100.0% [42] 186(1.1%) 0(0.0%) ??? ...ects/racket/contract/private/prop.rkt:567:4 ??? [48] 100.0% ------------------------------------------------------------------------------- egraph-run [36] 100.0% [43] 486(3.0%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [50] 100.0% ------------------------------------------------------------------------------- taylor-alt [39] 100.0% [44] 268(1.6%) 0(0.0%) for-loop ...erbie/better-rr/src/mainloop.rkt:151:6 ??? [49] 100.0% ------------------------------------------------------------------------------- matcher [2] 50.0% rewrite-expression-head23 [40] 50.0% [45] 210(1.3%) 0(0.0%) rewriter ...ie/better-rr/src/core/matcher.rkt:85:2 for-loop [51] 100.0% ------------------------------------------------------------------------------- random-ranges [37] 100.0% [46] 202(1.2%) 202(1.2%) cons/c .../racket/contract/private/guts.rkt:500:15 ------------------------------------------------------------------------------- random-ranges [37] 100.0% [47] 186(1.1%) 186(1.1%) build--> ...act/private/arrow-val-first.rkt:1214:0 ------------------------------------------------------------------------------- ??? [42] 100.0% [48] 186(1.1%) 186(1.1%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ------------------------------------------------------------------------------- location-do [58] 1.5% for-loop [44] 1.5% ??? [21] 2.1% real->precision [27] 6.6% loop [20] 88.4% [49] 9214(56.2%) 1210(7.4%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-pow-pos [52] 34.6% ival-pow-neg [53] 21.3% ival-fmod-pos [60] 13.1% ival-fmod [54] 10.7% bf [56] 4.2% location-do [58] 1.5% approximate9 [57] 1.5% ------------------------------------------------------------------------------- egraph-add-exprs [43] 100.0% [50] 486(3.0%) 0(0.0%) ??? ...erbie/better-rr/src/core/simplify.rkt:103:6 for-loop [55] 100.0% ------------------------------------------------------------------------------- rewriter [45] 100.0% [51] 210(1.3%) 0(0.0%) for-loop ...ie/better-rr/src/core/matcher.rkt:87:4 hash-ref! [59] 100.0% ------------------------------------------------------------------------------- ??? [49] 100.0% [52] 3186(19.4%) 1982(12.1%) ival-pow-pos ...etter-rr/src/biginterval.rkt:224:0 bfsub [64] 37.8% ------------------------------------------------------------------------------- ??? [49] 100.0% [53] 1964(12.0%) 198(1.2%) ival-pow-neg ...etter-rr/src/biginterval.rkt:245:0 ival-fabs [61] 38.8% bfodd? [62] 31.4% bftruncate [66] 19.8% ------------------------------------------------------------------------------- ??? [49] 100.0% [54] 990(6.0%) 206(1.3%) ival-fmod ...e/better-rr/src/biginterval.rkt:425:0 ival-fabs [61] 59.8% ival-fmod-pos [60] 19.4% ------------------------------------------------------------------------------- ??? [50] 100.0% [55] 486(3.0%) 486(3.0%) for-loop .../better-rr/src/core/simplify.rkt:121:2 ------------------------------------------------------------------------------- ??? [49] 100.0% [56] 390(2.4%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [69] 100.0% ------------------------------------------------------------------------------- ??? [49] 100.0% [57] 268(1.6%) 0(0.0%) approximate9 ...better-rr/src/core/taylor.rkt:11:0 for-loop [63] 100.0% ------------------------------------------------------------------------------- location-do [58] 50.0% ??? [49] 50.0% [58] 268(1.6%) 0(0.0%) location-do ...bie/better-rr/src/programs.rkt:87:0 location-do [58] 50.0% ??? [49] 50.0% ------------------------------------------------------------------------------- for-loop [6] 33.3% for-loop [51] 66.7% [59] 210(1.3%) 210(1.3%) hash-ref! .../racket/private/more-scheme.rkt:376:2 matcher [2] 66.7% ------------------------------------------------------------------------------- ival-fmod [54] 13.7% ??? [49] 86.3% [60] 1398(8.5%) 402(2.5%) ival-fmod-pos ...tter-rr/src/biginterval.rkt:407:0 bftruncate [66] 42.8% bfsub [64] 28.5% ------------------------------------------------------------------------------- ival-fmod [54] 43.7% ival-pow-neg [53] 56.3% [61] 1354(8.3%) 0(0.0%) ival-fabs ...e/better-rr/src/biginterval.rkt:378:0 bfsinh [65] 100.0% ------------------------------------------------------------------------------- ival-pow-neg [53] 100.0% [62] 616(3.8%) 0(0.0%) bfodd? ...lib/math/private/bigfloat/mpfr.rkt:817:0 new-mpz [67] 100.0% ------------------------------------------------------------------------------- approximate9 [57] 100.0% [63] 268(1.6%) 0(0.0%) for-loop ...ie/better-rr/src/core/taylor.rkt:29:18 taylor [68] 100.0% ------------------------------------------------------------------------------- ival-fmod-pos [60] 17.6% ival-sub [35] 29.2% ival-pow-pos [52] 53.2% [64] 2264(13.8%) 200(1.2%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [70] 55.0% new-mpfr [69] 36.1% ------------------------------------------------------------------------------- ival-sinh [34] 38.6% ival-fabs [61] 61.4% [65] 2206(13.4%) 186(1.1%) bfsinh ...lib/math/private/bigfloat/mpfr.rkt:632:4 new-mpfr [69] 55.5% ??? [70] 36.1% ------------------------------------------------------------------------------- ival-pow-neg [53] 39.4% ival-fmod-pos [60] 60.6% [66] 986(6.0%) 200(1.2%) bftruncate ...math/private/bigfloat/mpfr.rkt:730:4 new-mpfr [69] 40.4% ??? [70] 39.4% ------------------------------------------------------------------------------- bfodd? [62] 100.0% [67] 616(3.8%) 616(3.8%) new-mpz ...-lib/math/private/bigfloat/gmp.rkt:73:0 ------------------------------------------------------------------------------- for-loop [63] 25.0% taylor [68] 75.0% [68] 268(1.6%) 0(0.0%) taylor ...rbie/better-rr/src/core/taylor.rkt:169:0 taylor [68] 75.0% taylor-quotient [71] 25.0% ------------------------------------------------------------------------------- bf [56] 13.8% bftruncate [66] 14.1% bfsub [64] 28.9% bfsinh [65] 43.3% [69] 2830(17.2%) 2830(17.2%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ------------------------------------------------------------------------------- bftruncate [66] 16.0% bfsinh [65] 32.8% bfsub [64] 51.3% [70] 2430(14.8%) 2430(14.8%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ------------------------------------------------------------------------------- taylor [68] 100.0% [71] 268(1.6%) 0(0.0%) taylor-quotient ...er-rr/src/core/taylor.rkt:333:0 parse-loop74 [72] 100.0% ------------------------------------------------------------------------------- taylor-quotient [71] 100.0% [72] 268(1.6%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [73] 100.0% ------------------------------------------------------------------------------- parse-loop74 [72] 100.0% [73] 268(1.6%) 0(0.0%) eval-const-expr ...etter-rr/src/programs.rkt:144:0 temp85_0 [74] 100.0% ------------------------------------------------------------------------------- eval-const-expr [73] 100.0% [74] 268(1.6%) 0(0.0%) temp85_0 (unknown source) compile15 [75] 100.0% ------------------------------------------------------------------------------- temp85_0 [74] 100.0% [75] 268(1.6%) 0(0.0%) compile15 (unknown source) temp91_0 [76] 100.0% ------------------------------------------------------------------------------- compile15 [75] 100.0% [76] 268(1.6%) 0(0.0%) temp91_0 (unknown source) compile-top9 [77] 100.0% ------------------------------------------------------------------------------- temp91_0 [76] 100.0% [77] 268(1.6%) 0(0.0%) compile-top9 (unknown source) compile-forms33 [78] 100.0% ------------------------------------------------------------------------------- compile-top9 [77] 100.0% [78] 268(1.6%) 0(0.0%) compile-forms33 (unknown source) serialize-phase-to-link-module-uses [79]100.0% ------------------------------------------------------------------------------- compile-forms33 [78] 100.0% [79] 268(1.6%) 268(1.6%) serialize-phase-to-link-module-uses ...own source) -------------------------------------------------------------------------------