Profiling results ----------------- Total cpu time observed: 10888ms (out of 11764ms) Number of samples taken: 52 (once every 209ms) ===================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ===================================================================== [1] 10888(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 100.0% --------------------------------------------------------------------- matcher [79] 100.0% [2] 220(2.0%) 0(0.0%) ??? ...herbie/findroot/src/core/matcher.rkt:131:11 for-loop [4] 100.0% --------------------------------------------------------------------- ??? [1] 100.0% [3] 10888(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% --------------------------------------------------------------------- ??? [2] 100.0% [4] 220(2.0%) 0(0.0%) for-loop ...e/findroot/src/core/matcher.rkt:133:15 hash-ref! [77] 100.0% --------------------------------------------------------------------- profile-thunk16 [3] 100.0% [5] 10888(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [6]100.0% --------------------------------------------------------------------- for-loop [64] 4.7% run [5] 95.3% [6] 10888(100.0%) 832(7.6%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [10] 75.9% run-improve47 [7] 14.6% errors [58] 2.9% oracle-error [9] 1.8% ??? [8] 0.9% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [7] 1790(16.4%) 0(0.0%) run-improve47 ...e/findroot/src/mainloop.rkt:346:0 for-loop [11] 61.5% prepare-points-intervals [10] 26.0% simplify! [18] 12.5% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [8] 200(1.8%) 200(1.8%) ??? ...erbie/findroot/src/syntax/syntax.rkt:214:17 --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [9] 200(1.8%) 0(0.0%) oracle-error ...rbie/findroot/src/points.rkt:177:0 for-loop [12] 100.0% --------------------------------------------------------------------- run-improve47 [7] 5.3% .../more-scheme.rkt:261:28 [6] 94.7% [10] 8732(80.2%) 0(0.0%) prepare-points-intervals ...t/src/points.rkt:120:0 loop [13] 97.3% loop [15] 2.7% --------------------------------------------------------------------- run-improve47 [7] 100.0% [11] 1100(10.1%) 0(0.0%) for-loop ...herbie/findroot/src/mainloop.rkt:365:4 run-iter! [14] 100.0% --------------------------------------------------------------------- oracle-error [9] 100.0% [12] 200(1.8%) 0(0.0%) for-loop ...s/herbie/findroot/src/points.rkt:178:2 loop [15] 100.0% --------------------------------------------------------------------- prepare-points-intervals [10] 100.0% [13] 8492(78.0%) 404(3.7%) loop ...tlies/herbie/findroot/src/points.rkt:132:4 loop [16] 76.0% ??? [17] 16.9% do-curry [24] 2.4% --------------------------------------------------------------------- for-loop [11] 100.0% [14] 1100(10.1%) 0(0.0%) run-iter! ...erbie/findroot/src/mainloop.rkt:327:0 finalize-iter! [19] 36.4% simplify! [18] 21.8% gen-series! [22] 21.8% gen-rewrites! [23] 20.0% --------------------------------------------------------------------- loop [15] 18.2% expand-capturing-lifts [20] 18.2% prepare-points-intervals [10] 18.2% for-loop [12] 45.5% [15] 440(4.0%) 0(0.0%) loop (unknown source) ??? [25] 45.5% expand-capturing-lifts [20] 18.2% loop [15] 18.2% for-loop [21] 18.2% --------------------------------------------------------------------- loop [13] 100.0% [16] 6450(59.2%) 1274(11.7%) loop ...htlies/herbie/findroot/src/points.rkt:79:2 ??? [26] 47.4% ??? [57] 19.1% real->precision [28] 10.3% log! [34] 3.4% --------------------------------------------------------------------- loop [13] 100.0% [17] 1436(13.2%) 200(1.8%) ??? ...htlies/herbie/findroot/src/points.rkt:113:6 sample-multi-bounded [27] 86.1% --------------------------------------------------------------------- run-improve47 [7] 48.3% run-iter! [14] 51.7% [18] 464(4.3%) 0(0.0%) simplify! ...erbie/findroot/src/mainloop.rkt:224:0 ??? [29] 100.0% --------------------------------------------------------------------- run-iter! [14] 100.0% [19] 400(3.7%) 0(0.0%) finalize-iter! .../findroot/src/mainloop.rkt:278:0 ??? [30] 100.0% --------------------------------------------------------------------- loop [15] 100.0% [20] 240(2.2%) 0(0.0%) expand-capturing-lifts (unknown source) loop [15] 100.0% --------------------------------------------------------------------- run-module-instance!125 [32] 50.0% loop [15] 50.0% [21] 240(2.2%) 0(0.0%) for-loop (unknown source) run-module-instance!125 [32] 50.0% temp37_0 [31] 50.0% --------------------------------------------------------------------- run-iter! [14] 100.0% [22] 240(2.2%) 0(0.0%) gen-series! ...bie/findroot/src/mainloop.rkt:160:0 for-loop [33] 100.0% --------------------------------------------------------------------- run-iter! [14] 100.0% [23] 220(2.0%) 0(0.0%) gen-rewrites! ...e/findroot/src/mainloop.rkt:183:0 for-loop [35] 100.0% --------------------------------------------------------------------- loop [13] 100.0% [24] 202(1.9%) 202(1.9%) do-curry ...-7.5/collects/racket/function.rkt:71:2 --------------------------------------------------------------------- loop [15] 100.0% [25] 200(1.8%) 200(1.8%) ??? ...tlies/herbie/findroot/src/points.rkt:179:26 --------------------------------------------------------------------- loop [16] 100.0% [26] 3058(28.1%) 200(1.8%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-sin [36] 59.9% ival-atan2 [39] 13.9% ival-sub [40] 13.1% ival-sqrt [47] 6.5% --------------------------------------------------------------------- ??? [17] 100.0% [27] 1236(11.4%) 206(1.9%) sample-multi-bounded ...ndroot/src/points.rkt:14:0 random-ranges [37] 66.7% for-loop [46] 16.7% --------------------------------------------------------------------- loop [16] 100.0% [28] 662(6.1%) 0(0.0%) real->precision ...findroot/src/programs.rkt:94:11 ??? [57] 100.0% --------------------------------------------------------------------- simplify! [18] 100.0% [29] 464(4.3%) 0(0.0%) ??? .../herbie/findroot/src/core/simplify.rkt:42:0 egraph-run [38] 100.0% --------------------------------------------------------------------- finalize-iter! [19] 100.0% [30] 400(3.7%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [41] 100.0% --------------------------------------------------------------------- for-loop [21] 100.0% [31] 240(2.2%) 0(0.0%) temp37_0 (unknown source) [running body] [42] 100.0% --------------------------------------------------------------------- for-loop [21] 100.0% [32] 240(2.2%) 0(0.0%) run-module-instance!125 (unknown source) for-loop [21] 100.0% --------------------------------------------------------------------- gen-series! [22] 100.0% [33] 240(2.2%) 0(0.0%) for-loop ...herbie/findroot/src/mainloop.rkt:167:7 taylor-alt [43] 100.0% --------------------------------------------------------------------- loop [16] 100.0% [34] 222(2.0%) 0(0.0%) log! ...htlies/herbie/findroot/src/points.rkt:59:2 for-loop [44] 100.0% --------------------------------------------------------------------- gen-rewrites! [23] 100.0% [35] 220(2.0%) 0(0.0%) for-loop ...erbie/findroot/src/mainloop.rkt:191:11 rewrite-expression-head24 [45]100.0% --------------------------------------------------------------------- ??? [26] 100.0% [36] 1832(16.8%) 608(5.6%) ival-sin ...bie/findroot/src/biginterval.rkt:304:0 bffloor [48] 33.8% bfexpt [70] 21.9% bfsin [55] 11.0% --------------------------------------------------------------------- sample-multi-bounded [27] 100.0% [37] 824(7.6%) 220(2.0%) random-ranges ...bie/findroot/src/common.rkt:164:0 cons/c [50] 48.8% build--> [54] 24.5% --------------------------------------------------------------------- ??? [29] 100.0% [38] 464(4.3%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [49] 100.0% --------------------------------------------------------------------- ??? [26] 100.0% [39] 426(3.9%) 426(3.9%) ival-atan2 ...e/findroot/src/biginterval.rkt:336:0 --------------------------------------------------------------------- ??? [26] 100.0% [40] 400(3.7%) 0(0.0%) ival-sub ...bie/findroot/src/biginterval.rkt:117:0 bfexpt [70] 100.0% --------------------------------------------------------------------- ??? [30] 100.0% [41] 400(3.7%) 0(0.0%) for-loop ...e/findroot/src/core/alt-table.rkt:46:2 errors [58] 50.0% atab-add-altn [56] 50.0% --------------------------------------------------------------------- temp37_0 [31] 100.0% [42] 240(2.2%) 0(0.0%) [running body] ....5/collects/racket/port.rkt":##f .get-syntax-literal! [51] 100.0% --------------------------------------------------------------------- for-loop [33] 100.0% [43] 240(2.2%) 0(0.0%) taylor-alt ...rbie/findroot/src/mainloop.rkt:146:0 for-loop [52] 100.0% --------------------------------------------------------------------- log! [34] 100.0% [44] 222(2.0%) 222(2.0%) for-loop ...s/herbie/findroot/src/points.rkt:66:23 --------------------------------------------------------------------- for-loop [35] 100.0% [45] 220(2.0%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [53] 100.0% --------------------------------------------------------------------- sample-multi-bounded [27] 100.0% [46] 206(1.9%) 206(1.9%) for-loop ...es/herbie/findroot/src/points.rkt:20:4 --------------------------------------------------------------------- ??? [26] 100.0% [47] 200(1.8%) 200(1.8%) ival-sqrt ...ie/findroot/src/biginterval.rkt:205:0 --------------------------------------------------------------------- ival-sin [36] 100.0% [48] 620(5.7%) 0(0.0%) bffloor ...ib/math/private/bigfloat/mpfr.rkt:730:4 new-mpfr [74] 64.8% ??? [73] 35.2% --------------------------------------------------------------------- egraph-run [38] 100.0% [49] 464(4.3%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [59] 100.0% --------------------------------------------------------------------- random-ranges [37] 100.0% [50] 402(3.7%) 0(0.0%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [60] 100.0% --------------------------------------------------------------------- [running body] [42] 100.0% [51] 240(2.2%) 0(0.0%) .get-syntax-literal! (unknown source) .deserialize-syntax [61] 100.0% --------------------------------------------------------------------- taylor-alt [43] 100.0% [52] 240(2.2%) 0(0.0%) for-loop ...herbie/findroot/src/mainloop.rkt:152:6 ??? [57] 100.0% --------------------------------------------------------------------- matcher [79] 50.0% rewrite-expression-head24 [45] 50.0% [53] 220(2.0%) 0(0.0%) rewriter ...bie/findroot/src/core/matcher.rkt:87:2 for-loop [62] 100.0% --------------------------------------------------------------------- random-ranges [37] 100.0% [54] 202(1.9%) 202(1.9%) build--> ...act/private/arrow-val-first.rkt:1214:0 --------------------------------------------------------------------- ival-sin [36] 100.0% [55] 202(1.9%) 0(0.0%) bfsin ...-lib/math/private/bigfloat/mpfr.rkt:632:4 ??? [73] 100.0% --------------------------------------------------------------------- for-loop [41] 100.0% [56] 200(1.8%) 0(0.0%) atab-add-altn ...root/src/core/alt-table.rkt:194:0 errors [58] 100.0% --------------------------------------------------------------------- location-do [67] 5.6% for-loop [52] 5.6% real->precision [28] 31.0% loop [16] 57.8% [57] 2136(19.6%) 638(5.9%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-pow-pos [63] 48.4% ??? [69] 10.5% location-do [67] 5.6% approximate9 [68] 5.6% --------------------------------------------------------------------- atab-add-altn [56] 19.4% for-loop [41] 19.4% .../more-scheme.rkt:261:28 [6] 61.2% [58] 1032(9.5%) 0(0.0%) errors ...ies/herbie/findroot/src/points.rkt:190:0 for-loop [64] 100.0% --------------------------------------------------------------------- egraph-add-exprs [49] 100.0% [59] 464(4.3%) 0(0.0%) ??? ...herbie/findroot/src/core/simplify.rkt:102:6 for-loop [65] 100.0% --------------------------------------------------------------------- cons/c [50] 100.0% [60] 402(3.7%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [66] 100.0% --------------------------------------------------------------------- .get-syntax-literal! [51] 100.0% [61] 240(2.2%) 240(2.2%) .deserialize-syntax (unknown source) --------------------------------------------------------------------- rewriter [53] 100.0% [62] 220(2.0%) 220(2.0%) for-loop ...bie/findroot/src/core/matcher.rkt:89:4 hash-ref! [77] 50.0% --------------------------------------------------------------------- ??? [57] 100.0% [63] 1034(9.5%) 634(5.8%) ival-pow-pos ...findroot/src/biginterval.rkt:224:0 bfexpt [70] 38.7% --------------------------------------------------------------------- errors [58] 100.0% [64] 1032(9.5%) 0(0.0%) for-loop ...s/herbie/findroot/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [6]100.0% --------------------------------------------------------------------- ??? [59] 100.0% [65] 464(4.3%) 464(4.3%) for-loop ...e/findroot/src/core/simplify.rkt:121:2 --------------------------------------------------------------------- coerce-contract [60] 100.0% [66] 402(3.7%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [71] 100.0% --------------------------------------------------------------------- location-do [67] 50.0% ??? [57] 50.0% [67] 240(2.2%) 0(0.0%) location-do ...rbie/findroot/src/programs.rkt:63:0 location-do [67] 50.0% ??? [57] 50.0% --------------------------------------------------------------------- ??? [57] 100.0% [68] 240(2.2%) 0(0.0%) approximate9 .../findroot/src/core/taylor.rkt:11:0 for-loop [72] 100.0% --------------------------------------------------------------------- ??? [57] 100.0% [69] 224(2.1%) 224(2.1%) ??? ...ects/racket/contract/private/guts.rkt:770:8 --------------------------------------------------------------------- ival-pow-pos [63] 33.3% ival-sub [40] 33.3% ival-sin [36] 33.4% [70] 1202(11.0%) 202(1.9%) bfexpt ...lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [73] 49.9% new-mpfr [74] 33.3% --------------------------------------------------------------------- coerce-contract/f [66] 100.0% [71] 402(3.7%) 402(3.7%) coerce-simple-value ...ract/private/guts.rkt:385:0 --------------------------------------------------------------------- approximate9 [68] 100.0% [72] 240(2.2%) 0(0.0%) for-loop ...bie/findroot/src/core/taylor.rkt:29:18 taylor [75] 100.0% --------------------------------------------------------------------- bfsin [55] 19.8% bffloor [48] 21.4% bfexpt [70] 58.8% [73] 1020(9.4%) 1020(9.4%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 --------------------------------------------------------------------- bfexpt [70] 49.9% bffloor [48] 50.1% [74] 802(7.4%) 802(7.4%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 --------------------------------------------------------------------- for-loop [72] 100.0% [75] 240(2.2%) 0(0.0%) taylor ...erbie/findroot/src/core/taylor.rkt:169:0 loop [76] 100.0% --------------------------------------------------------------------- taylor [75] 100.0% [76] 240(2.2%) 0(0.0%) loop .../herbie/findroot/src/core/taylor.rkt:267:2 hash-ref! [77] 100.0% --------------------------------------------------------------------- for-loop [4] 23.9% for-loop [62] 23.9% loop [76] 52.2% [77] 460(4.2%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 f40 [78] 52.2% matcher [79] 47.8% --------------------------------------------------------------------- hash-ref! [77] 20.0% map [80] 80.0% [78] 240(2.2%) 0(0.0%) f40 (unknown source) map [80] 100.0% --------------------------------------------------------------------- hash-ref! [77] 100.0% [79] 220(2.0%) 0(0.0%) matcher ...bie/findroot/src/core/matcher.rkt:119:2 ??? [2] 50.0% rewriter [53] 50.0% --------------------------------------------------------------------- f40 [78] 100.0% [80] 240(2.2%) 240(2.2%) map ...t-7.5/collects/racket/private/map.rkt:35:13 f40 [78] 80.0% ---------------------------------------------------------------------