Profiling results ----------------- Total cpu time observed: 3310ms (out of 3528ms) Number of samples taken: 19 (once every 174ms) ==================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ==================================================================== [1] 3310(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [5] 100.0% -------------------------------------------------------------------- ??? [56] 100.0% [2] 326(9.8%) 0(0.0%) approximate9 ...ie/master/src/core/taylor.rkt:11:0 loop [6] 54.0% taylor [52] 46.0% -------------------------------------------------------------------- for-loop [74] 100.0% [3] 152(4.6%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [7] 100.0% -------------------------------------------------------------------- matcher [55] 100.0% [4] 148(4.5%) 0(0.0%) ??? ...s/herbie/master/src/core/matcher.rkt:129:11 for-loop [8] 100.0% -------------------------------------------------------------------- ??? [1] 100.0% [5] 3310(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [9] 100.0% -------------------------------------------------------------------- approximate9 [2] 100.0% [6] 176(5.3%) 0(0.0%) loop ...ies/herbie/master/src/core/taylor.rkt:86:4 hash-ref! [49] 100.0% -------------------------------------------------------------------- expand-identifier [3] 100.0% [7] 152(4.6%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [10] 100.0% -------------------------------------------------------------------- ??? [4] 100.0% [8] 148(4.5%) 0(0.0%) for-loop ...bie/master/src/core/matcher.rkt:131:15 hash-ref! [49] 100.0% -------------------------------------------------------------------- profile-thunk16 [5] 100.0% [9] 3310(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [11]100.0% -------------------------------------------------------------------- resolve+shift28 [7] 100.0% [10] 152(4.6%) 0(0.0%) fallback-loop (unknown source) for-loop [74] 100.0% -------------------------------------------------------------------- for-loop [48] 5.0% run [9] 95.0% [11] 3310(100.0%) 160(4.8%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [12] 56.4% run-improve47 [13] 28.8% errors [44] 5.0% oracle-error [14] 4.7% ??? [56] 2.6% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11]100.0% [12] 1868(56.4%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:122:0 loop [15] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11]100.0% [13] 954(28.8%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:364:0 for-loop [16] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11]100.0% [14] 156(4.7%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:179:0 for-loop [17] 100.0% -------------------------------------------------------------------- prepare-points-intervals [12] 100.0% [15] 1868(56.4%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:134:4 loop [18] 81.3% ??? [20] 18.7% -------------------------------------------------------------------- run-improve47 [13] 100.0% [16] 954(28.8%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:383:4 run-iter! [19] 100.0% -------------------------------------------------------------------- oracle-error [14] 100.0% [17] 156(4.7%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:180:2 loop [21] 100.0% -------------------------------------------------------------------- loop [15] 100.0% [18] 1518(45.9%) 192(5.8%) loop ...ightlies/herbie/master/src/points.rkt:79:2 ??? [56] 60.5% real->precision [22] 26.9% -------------------------------------------------------------------- for-loop [16] 100.0% [19] 954(28.8%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:345:0 gen-series! [24] 34.2% finalize-iter! [25] 31.9% simplify! [26] 18.4% gen-rewrites! [28] 15.5% -------------------------------------------------------------------- loop [15] 100.0% [20] 350(10.6%) 0(0.0%) ??? ...ightlies/herbie/master/src/points.rkt:115:6 sample-multi-bounded [23] 100.0% -------------------------------------------------------------------- for-loop [17] 100.0% [21] 156(4.7%) 0(0.0%) loop (unknown source) ulp-difference [27] 100.0% -------------------------------------------------------------------- loop [18] 100.0% [22] 408(12.3%) 0(0.0%) real->precision .../master/src/programs.rkt:118:11 ??? [56] 100.0% -------------------------------------------------------------------- ??? [20] 100.0% [23] 350(10.6%) 0(0.0%) sample-multi-bounded ...master/src/points.rkt:14:0 for-loop [31] 57.1% random-ranges [33] 42.9% -------------------------------------------------------------------- run-iter! [19] 100.0% [24] 326(9.8%) 0(0.0%) gen-series! ...erbie/master/src/mainloop.rkt:159:0 for-loop [29] 100.0% -------------------------------------------------------------------- run-iter! [19] 100.0% [25] 304(9.2%) 0(0.0%) finalize-iter! ...ie/master/src/mainloop.rkt:277:0 ??? [30] 100.0% -------------------------------------------------------------------- run-iter! [19] 100.0% [26] 176(5.3%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:223:0 ??? [32] 100.0% -------------------------------------------------------------------- loop [21] 100.0% [27] 156(4.7%) 156(4.7%) ulp-difference ...herbie/master/src/float.rkt:19:0 -------------------------------------------------------------------- run-iter! [19] 100.0% [28] 148(4.5%) 0(0.0%) gen-rewrites! ...bie/master/src/mainloop.rkt:182:0 for-loop [34] 100.0% -------------------------------------------------------------------- gen-series! [24] 100.0% [29] 326(9.8%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:166:7 taylor-alt [35] 100.0% -------------------------------------------------------------------- finalize-iter! [25] 100.0% [30] 304(9.2%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [36] 100.0% -------------------------------------------------------------------- sample-multi-bounded [23] 100.0% [31] 200(6.0%) 200(6.0%) for-loop ...lies/herbie/master/src/points.rkt:20:4 -------------------------------------------------------------------- simplify! [26] 100.0% [32] 176(5.3%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:42:0 egraph-run [37] 100.0% -------------------------------------------------------------------- sample-multi-bounded [23] 100.0% [33] 150(4.5%) 150(4.5%) random-ranges ...erbie/master/src/common.rkt:164:0 -------------------------------------------------------------------- gen-rewrites! [28] 100.0% [34] 148(4.5%) 0(0.0%) for-loop .../herbie/master/src/mainloop.rkt:190:11 rewrite-expression-head23 [38] 100.0% -------------------------------------------------------------------- for-loop [29] 100.0% [35] 326(9.8%) 0(0.0%) taylor-alt ...herbie/master/src/mainloop.rkt:145:0 for-loop [39] 100.0% -------------------------------------------------------------------- ??? [30] 100.0% [36] 304(9.2%) 0(0.0%) for-loop ...ie/master/src/core/alt-table.rkt:192:2 atab-add-altn [42] 50.0% loop [41] 50.0% -------------------------------------------------------------------- ??? [32] 100.0% [37] 176(5.3%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [40] 100.0% -------------------------------------------------------------------- for-loop [34] 100.0% [38] 148(4.5%) 0(0.0%) rewrite-expression-head23 ...core/matcher.rkt:83:0 rewriter [43] 100.0% -------------------------------------------------------------------- taylor-alt [35] 100.0% [39] 326(9.8%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:151:6 ??? [56] 100.0% -------------------------------------------------------------------- egraph-run [37] 100.0% [40] 176(5.3%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [45] 100.0% -------------------------------------------------------------------- for-loop [36] 100.0% [41] 152(4.6%) 0(0.0%) loop ...herbie/master/src/core/alt-table.rkt:159:2 filter [46] 100.0% -------------------------------------------------------------------- for-loop [36] 100.0% [42] 152(4.6%) 0(0.0%) atab-add-altn ...ster/src/core/alt-table.rkt:195:0 errors [44] 100.0% -------------------------------------------------------------------- rewrite-expression-head23 [38] 25.0% matcher [55] 75.0% [43] 148(4.5%) 0(0.0%) rewriter ...erbie/master/src/core/matcher.rkt:85:2 for-loop [47] 100.0% -------------------------------------------------------------------- atab-add-altn [42] 31.4% .../more-scheme.rkt:261:28 [11] 68.6% [44] 484(14.6%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:192:0 for-loop [48] 68.6% temp85_0 [51] 31.4% -------------------------------------------------------------------- egraph-add-exprs [40] 100.0% [45] 176(5.3%) 0(0.0%) ??? ...s/herbie/master/src/core/simplify.rkt:103:6 for-loop [50] 100.0% -------------------------------------------------------------------- loop [41] 100.0% [46] 152(4.6%) 152(4.6%) filter ...5/collects/racket/private/list.rkt:256:2 -------------------------------------------------------------------- rewriter [43] 100.0% [47] 148(4.5%) 0(0.0%) for-loop ...erbie/master/src/core/matcher.rkt:87:4 hash-ref! [49] 100.0% -------------------------------------------------------------------- errors [44] 100.0% [48] 332(10.0%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:194:2 .../more-scheme.rkt:261:28 [11]100.0% -------------------------------------------------------------------- for-loop [8] 22.8% for-loop [47] 22.8% ??? [56] 27.2% loop [6] 27.2% [49] 324(9.8%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 matcher [55] 45.7% ??? [53] 27.2% taylor [52] 27.2% -------------------------------------------------------------------- ??? [45] 100.0% [50] 176(5.3%) 176(5.3%) for-loop ...bie/master/src/core/simplify.rkt:121:2 -------------------------------------------------------------------- errors [44] 100.0% [51] 152(4.6%) 0(0.0%) temp85_0 (unknown source) compile15 [54] 100.0% -------------------------------------------------------------------- map [60] 15.3% approximate9 [2] 15.3% hash-ref! [49] 27.0% taylor [52] 42.3% [52] 326(9.8%) 0(0.0%) taylor .../herbie/master/src/core/taylor.rkt:169:0 taylor [52] 42.3% debug5 [57] 27.0% map [60] 15.3% debug-print [59] 15.3% -------------------------------------------------------------------- hash-ref! [49] 100.0% [53] 176(5.3%) 0(0.0%) ??? ...ies/herbie/master/src/core/taylor.rkt:67:15 ??? [56] 100.0% -------------------------------------------------------------------- temp85_0 [51] 100.0% [54] 152(4.6%) 0(0.0%) compile15 (unknown source) temp91_0 [58] 100.0% -------------------------------------------------------------------- hash-ref! [49] 100.0% [55] 148(4.5%) 148(4.5%) matcher ...erbie/master/src/core/matcher.rkt:117:2 ??? [4] 50.0% rewriter [43] 37.5% -------------------------------------------------------------------- ??? [53] 3.2% location-do [63] 7.3% for-loop [39] 7.3% .../more-scheme.rkt:261:28 [11] 9.4% real->precision [22] 22.4% loop [18] 50.3% [56] 1824(55.1%) 372(11.2%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-div [61] 28.8% ival-mult [62] 21.5% bf [64] 11.4% location-do [63] 7.3% approximate9 [2] 7.3% hash-ref! [49] 3.2% -------------------------------------------------------------------- taylor [52] 100.0% [57] 176(5.3%) 176(5.3%) debug5 ...htlies/herbie/master/src/debug.rkt:102:0 -------------------------------------------------------------------- compile15 [54] 100.0% [58] 152(4.6%) 0(0.0%) temp91_0 (unknown source) temp118_0 [65] 100.0% -------------------------------------------------------------------- taylor [52] 100.0% [59] 150(4.5%) 0(0.0%) debug-print ...s/herbie/master/src/debug.rkt:110:0 ??? [66] 100.0% -------------------------------------------------------------------- taylor [52] 100.0% [60] 150(4.5%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 taylor [52] 100.0% -------------------------------------------------------------------- ??? [56] 100.0% [61] 526(15.9%) 0(0.0%) ival-div ...erbie/master/src/biginterval.rkt:149:0 bfdiv [67] 100.0% -------------------------------------------------------------------- ??? [56] 100.0% [62] 392(11.8%) 0(0.0%) ival-mult ...rbie/master/src/biginterval.rkt:129:0 bfdiv [67] 100.0% -------------------------------------------------------------------- location-do [63] 27.0% ??? [56] 73.0% [63] 326(9.8%) 0(0.0%) location-do ...herbie/master/src/programs.rkt:87:0 ??? [56] 73.0% location-do [63] 27.0% -------------------------------------------------------------------- ??? [56] 100.0% [64] 208(6.3%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 ??? [71] 100.0% -------------------------------------------------------------------- temp91_0 [58] 100.0% [65] 152(4.6%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [68] 100.0% -------------------------------------------------------------------- debug-print [59] 100.0% [66] 150(4.5%) 0(0.0%) ??? .../contract/private/arrow-val-first.rkt:555:3 ~r92 [69] 100.0% -------------------------------------------------------------------- ival-mult [62] 42.7% ival-div [61] 57.3% [67] 918(27.7%) 0(0.0%) bfdiv ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [70] 61.7% ??? [71] 38.3% -------------------------------------------------------------------- temp118_0 [65] 100.0% [68] 152(4.6%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [72] 100.0% -------------------------------------------------------------------- ??? [66] 100.0% [69] 150(4.5%) 150(4.5%) ~r92 ...acket-7.5/collects/racket/format.rkt:189:0 -------------------------------------------------------------------- bfdiv [67] 100.0% [70] 566(17.1%) 566(17.1%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 -------------------------------------------------------------------- bf [64] 37.1% bfdiv [67] 62.9% [71] 560(16.9%) 560(16.9%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 -------------------------------------------------------------------- expand-capturing-lifts [68] 100.0% [72] 152(4.6%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [73] 100.0% -------------------------------------------------------------------- lambda-clause-expander [72] 12.5% for-loop [74] 87.5% [73] 152(4.6%) 0(0.0%) finish-bodys (unknown source) for-loop [74] 100.0% -------------------------------------------------------------------- fallback-loop [10] 9.1% for-loop [74] 18.2% finish-bodys [73] 72.7% [74] 152(4.6%) 152(4.6%) for-loop (unknown source) finish-bodys [73] 63.6% for-loop [74] 18.2% expand-identifier [3] 9.1% --------------------------------------------------------------------