Profiling results ----------------- Total cpu time observed: 4764ms (out of 4892ms) Number of samples taken: 24 (once every 198ms) ==================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ==================================================================== [1] 4764(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [10] 100.0% -------------------------------------------------------------------- location-do [2] 33.5% ??? [58] 66.5% [2] 558(11.7%) 0(0.0%) location-do ...herbie/master/src/programs.rkt:87:0 location-do [2] 33.5% loop [11] 33.5% ??? [58] 33.0% -------------------------------------------------------------------- ??? [58] 100.0% [3] 558(11.7%) 0(0.0%) approximate9 ...ie/master/src/core/taylor.rkt:11:0 loop [12] 34.1% for-loop [17] 33.0% taylor [19] 33.0% -------------------------------------------------------------------- hash-ref! [64] 100.0% [4] 190(4.0%) 0(0.0%) ??? ...ies/herbie/master/src/core/taylor.rkt:67:15 hash-ref! [64] 50.0% ??? [58] 50.0% -------------------------------------------------------------------- loop [87] 100.0% [5] 190(4.0%) 0(0.0%) gf (unknown source) cache-or-reuse-hash [14] 100.0% -------------------------------------------------------------------- loop [87] 100.0% [6] 190(4.0%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [13] 100.0% -------------------------------------------------------------------- hash-ref! [64] 100.0% [7] 190(4.0%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:300:23 for-loop [16] 100.0% -------------------------------------------------------------------- hash-ref! [64] 100.0% [8] 190(4.0%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:290:26 for-loop [15] 100.0% -------------------------------------------------------------------- taylor [19] 100.0% [9] 184(3.9%) 0(0.0%) taylor-quotient ...aster/src/core/taylor.rkt:333:0 parse-loop74 [67] 100.0% -------------------------------------------------------------------- ??? [1] 100.0% [10] 4764(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [18] 100.0% -------------------------------------------------------------------- loop [11] 32.8% location-do [2] 67.2% [11] 374(7.9%) 0(0.0%) loop ...htlies/herbie/master/src/programs.rkt:96:4 ??? [58] 67.2% loop [11] 32.8% -------------------------------------------------------------------- approximate9 [3] 100.0% [12] 190(4.0%) 0(0.0%) loop ...ies/herbie/master/src/core/taylor.rkt:86:4 hash-ref! [64] 100.0% -------------------------------------------------------------------- syntax-e [6] 100.0% [13] 190(4.0%) 0(0.0%) syntax-e/no-taint (unknown source) loop [87] 100.0% -------------------------------------------------------------------- gf [5] 100.0% [14] 190(4.0%) 0(0.0%) cache-or-reuse-hash (unknown source) for-loop [88] 100.0% -------------------------------------------------------------------- ??? [8] 100.0% [15] 190(4.0%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:290:52 hash-ref! [64] 100.0% -------------------------------------------------------------------- ??? [7] 100.0% [16] 190(4.0%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:303:27 hash-ref! [64] 100.0% -------------------------------------------------------------------- approximate9 [3] 100.0% [17] 184(3.9%) 0(0.0%) for-loop ...erbie/master/src/core/taylor.rkt:29:18 taylor [19] 100.0% -------------------------------------------------------------------- profile-thunk16 [10] 100.0% [18] 4764(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [20]100.0% -------------------------------------------------------------------- for-loop [17] 16.7% taylor [19] 25.0% approximate9 [3] 25.0% map [22] 33.3% [19] 368(7.7%) 0(0.0%) taylor .../herbie/master/src/core/taylor.rkt:169:0 map [22] 33.3% taylor [19] 25.0% variable? [21] 25.0% taylor-quotient [9] 16.7% -------------------------------------------------------------------- for-loop [60] 4.6% run [18] 95.4% [20] 4764(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [23] 37.6% run-improve47 [24] 34.1% errors-score [26] 4.6% ??? [25] 4.6% oracle-error [27] 4.3% ??? [28] 4.2% eval-errors [29] 4.2% get-final-combination [30] 3.9% errors [57] 2.4% -------------------------------------------------------------------- taylor [19] 100.0% [21] 184(3.9%) 184(3.9%) variable? ...ie/master/src/syntax/syntax.rkt:729:0 -------------------------------------------------------------------- taylor [19] 100.0% [22] 184(3.9%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 taylor [19] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [20]100.0% [23] 1790(37.6%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:122:0 loop [31] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [20]100.0% [24] 1726(36.2%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:365:0 for-loop [32] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [20]100.0% [25] 434(9.1%) 434(9.1%) ??? .../herbie/master/src/syntax/syntax.rkt:214:17 -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [20]100.0% [26] 220(4.6%) 0(0.0%) errors-score ...herbie/master/src/points.rkt:187:0 loop [87] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [20]100.0% [27] 206(4.3%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:179:0 for-loop [33] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [20]100.0% [28] 202(4.2%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ??? [34] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [20]100.0% [29] 200(4.2%) 0(0.0%) eval-errors .../herbie/master/src/points.rkt:170:0 for-loop [35] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [20]100.0% [30] 188(3.9%) 0(0.0%) get-final-combination ...er/src/mainloop.rkt:390:0 infer-splitpoints [36] 100.0% -------------------------------------------------------------------- prepare-points-intervals [23] 100.0% [31] 1790(37.6%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:134:4 ??? [38] 88.8% loop [40] 11.2% -------------------------------------------------------------------- run-improve47 [24] 100.0% [32] 1726(36.2%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:384:4 run-iter! [37] 100.0% -------------------------------------------------------------------- oracle-error [27] 100.0% [33] 206(4.3%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:180:2 loop [87] 100.0% -------------------------------------------------------------------- for-loop [39] 50.0% ??? [28] 50.0% [34] 202(4.2%) 202(4.2%) ??? ...cts/racket/contract/private/list.rkt:209:10 for-loop [39] 50.0% -------------------------------------------------------------------- eval-errors [29] 100.0% [35] 200(4.2%) 200(4.2%) for-loop ...ies/herbie/master/src/points.rkt:172:2 -------------------------------------------------------------------- get-final-combination [30] 100.0% [36] 188(3.9%) 0(0.0%) infer-splitpoints ...ter/src/core/regimes.rkt:33:0 for-loop [41] 100.0% -------------------------------------------------------------------- for-loop [32] 100.0% [37] 1726(36.2%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:346:0 simplify! [42] 34.5% finalize-iter! [43] 33.1% gen-series! [44] 32.3% -------------------------------------------------------------------- loop [31] 100.0% [38] 1590(33.4%) 200(4.2%) ??? ...ightlies/herbie/master/src/points.rkt:115:6 sample-multi-bounded [89] 74.8% loop [87] 12.6% -------------------------------------------------------------------- ??? [34] 100.0% [39] 202(4.2%) 0(0.0%) for-loop ...acket/contract/private/list.rkt:212:15 ??? [34] 100.0% -------------------------------------------------------------------- loop [31] 100.0% [40] 200(4.2%) 0(0.0%) loop ...ightlies/herbie/master/src/points.rkt:79:2 ??? [58] 100.0% -------------------------------------------------------------------- infer-splitpoints [36] 100.0% [41] 188(3.9%) 0(0.0%) for-loop ...erbie/master/src/core/regimes.rkt:45:6 option-on-expr [45] 100.0% -------------------------------------------------------------------- run-iter! [37] 100.0% [42] 596(12.5%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:224:0 ??? [46] 100.0% -------------------------------------------------------------------- run-iter! [37] 100.0% [43] 572(12.0%) 0(0.0%) finalize-iter! ...ie/master/src/mainloop.rkt:278:0 ??? [47] 100.0% -------------------------------------------------------------------- run-iter! [37] 100.0% [44] 558(11.7%) 0(0.0%) gen-series! ...erbie/master/src/mainloop.rkt:160:0 for-loop [48] 100.0% -------------------------------------------------------------------- for-loop [41] 100.0% [45] 188(3.9%) 0(0.0%) option-on-expr ...aster/src/core/regimes.rkt:124:0 debug-print [49] 100.0% -------------------------------------------------------------------- simplify! [42] 100.0% [46] 596(12.5%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:42:0 egraph-run [50] 100.0% -------------------------------------------------------------------- finalize-iter! [43] 100.0% [47] 572(12.0%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [51] 100.0% -------------------------------------------------------------------- gen-series! [44] 100.0% [48] 558(11.7%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:167:7 taylor-alt [52] 100.0% -------------------------------------------------------------------- option-on-expr [45] 100.0% [49] 188(3.9%) 0(0.0%) debug-print ...s/herbie/master/src/debug.rkt:110:0 ??? [53] 100.0% -------------------------------------------------------------------- ??? [46] 100.0% [50] 596(12.5%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [54] 100.0% -------------------------------------------------------------------- ??? [47] 100.0% [51] 572(12.0%) 0(0.0%) for-loop ...ie/master/src/core/alt-table.rkt:201:2 atab-add-altn [55] 100.0% -------------------------------------------------------------------- for-loop [48] 100.0% [52] 558(11.7%) 0(0.0%) taylor-alt ...herbie/master/src/mainloop.rkt:146:0 for-loop [56] 100.0% -------------------------------------------------------------------- debug-print [49] 100.0% [53] 188(3.9%) 188(3.9%) ??? .../contract/private/arrow-val-first.rkt:555:3 -------------------------------------------------------------------- egraph-run [50] 100.0% [54] 596(12.5%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [59] 100.0% -------------------------------------------------------------------- for-loop [51] 100.0% [55] 572(12.0%) 0(0.0%) atab-add-altn ...ster/src/core/alt-table.rkt:204:0 errors [57] 100.0% -------------------------------------------------------------------- taylor-alt [52] 100.0% [56] 558(11.7%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:152:6 ??? [58] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [20] 28.9% atab-add-altn [55] 71.1% [57] 804(16.9%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:192:0 for-loop [60] 54.0% temp85_0 [65] 23.1% eval-prog [66] 22.9% -------------------------------------------------------------------- ??? [4] 8.4% location-do [2] 12.1% loop [11] 20.5% loop [40] 26.4% for-loop [56] 32.6% [58] 758(15.9%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [2] 32.6% approximate9 [3] 32.6% ival-mult [62] 26.4% hash-ref! [64] 8.4% -------------------------------------------------------------------- egraph-add-exprs [54] 100.0% [59] 596(12.5%) 0(0.0%) ??? ...s/herbie/master/src/core/simplify.rkt:103:6 for-loop [61] 67.1% egg-run-rules [63] 32.9% -------------------------------------------------------------------- errors [57] 100.0% [60] 434(9.1%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:194:2 .../more-scheme.rkt:261:28 [20]100.0% -------------------------------------------------------------------- ??? [59] 100.0% [61] 400(8.4%) 400(8.4%) for-loop ...bie/master/src/core/simplify.rkt:121:2 -------------------------------------------------------------------- ??? [58] 100.0% [62] 200(4.2%) 0(0.0%) ival-mult ...rbie/master/src/biginterval.rkt:129:0 bfmul [68] 100.0% -------------------------------------------------------------------- ??? [59] 100.0% [63] 196(4.1%) 0(0.0%) egg-run-rules ...aster/src/core/simplify.rkt:109:0 make-ffi-rules [69] 100.0% -------------------------------------------------------------------- for-loop [16] 16.7% for-loop [15] 16.7% ??? [70] 16.7% ??? [58] 16.7% ??? [4] 16.7% loop [12] 16.7% [64] 190(4.0%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [4] 33.3% ??? [70] 16.7% ??? [8] 16.7% ??? [7] 16.7% parse-loop74 [67] 16.7% -------------------------------------------------------------------- errors [57] 100.0% [65] 186(3.9%) 0(0.0%) temp85_0 (unknown source) compile15 [71] 100.0% -------------------------------------------------------------------- errors [57] 100.0% [66] 184(3.9%) 0(0.0%) eval-prog .../herbie/master/src/programs.rkt:106:0 inductor [72] 100.0% -------------------------------------------------------------------- taylor-quotient [9] 49.2% hash-ref! [64] 50.8% [67] 374(7.9%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [73] 100.0% -------------------------------------------------------------------- ival-mult [62] 100.0% [68] 200(4.2%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [74] 100.0% -------------------------------------------------------------------- egg-run-rules [63] 100.0% [69] 196(4.1%) 0(0.0%) make-ffi-rules ...s/egg-herbie-linux/main.rkt:28:0 for-loop [75] 100.0% -------------------------------------------------------------------- hash-ref! [64] 100.0% [70] 190(4.0%) 0(0.0%) ??? ...ies/herbie/master/src/core/taylor.rkt:44:15 hash-ref! [64] 100.0% -------------------------------------------------------------------- temp85_0 [65] 100.0% [71] 186(3.9%) 0(0.0%) compile15 (unknown source) temp91_0 [76] 100.0% -------------------------------------------------------------------- inductor [72] 50.0% eval-prog [66] 50.0% [72] 184(3.9%) 0(0.0%) inductor ...s/herbie/master/src/programs.rkt:127:4 inductor [72] 50.0% constant? [77] 50.0% -------------------------------------------------------------------- parse-loop74 [67] 100.0% [73] 374(7.9%) 0(0.0%) eval-const-expr ...e/master/src/programs.rkt:144:0 loop [87] 50.8% eval4 [81] 49.2% -------------------------------------------------------------------- bfmul [68] 100.0% [74] 200(4.2%) 200(4.2%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 -------------------------------------------------------------------- make-ffi-rules [69] 100.0% [75] 196(4.1%) 0(0.0%) for-loop ....5/pkgs/egg-herbie-linux/main.rkt:29:2 to-egg-pattern [78] 100.0% -------------------------------------------------------------------- compile15 [71] 100.0% [76] 186(3.9%) 0(0.0%) temp91_0 (unknown source) temp118_0 [79] 100.0% -------------------------------------------------------------------- inductor [72] 100.0% [77] 184(3.9%) 0(0.0%) constant? ...ie/master/src/syntax/syntax.rkt:726:0 value? [80] 100.0% -------------------------------------------------------------------- to-egg-pattern [78] 50.0% for-loop [75] 50.0% [78] 196(4.1%) 196(4.1%) to-egg-pattern ...ie-linux/to-egg-pattern.rkt:17:0 to-egg-pattern [78] 50.0% -------------------------------------------------------------------- temp91_0 [76] 100.0% [79] 186(3.9%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [82] 100.0% -------------------------------------------------------------------- constant? [77] 100.0% [80] 184(3.9%) 184(3.9%) value? .../herbie/master/src/syntax/types.rkt:18:0 -------------------------------------------------------------------- eval-const-expr [73] 100.0% [81] 184(3.9%) 184(3.9%) eval4 (unknown source) -------------------------------------------------------------------- temp118_0 [79] 49.5% loop [87] 50.5% [82] 376(7.9%) 0(0.0%) expand-capturing-lifts (unknown source) dispatch-transformer41 [83] 50.5% lambda-clause-expander [84] 49.5% -------------------------------------------------------------------- expand-capturing-lifts [82] 100.0% [83] 190(4.0%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [85] 100.0% -------------------------------------------------------------------- expand-capturing-lifts [82] 100.0% [84] 186(3.9%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [86] 100.0% -------------------------------------------------------------------- dispatch-transformer41 [83] 100.0% [85] 190(4.0%) 0(0.0%) apply-transformer52 (unknown source) loop [87] 100.0% -------------------------------------------------------------------- for-loop [88] 50.0% lambda-clause-expander [84] 50.0% [86] 186(3.9%) 0(0.0%) finish-bodys (unknown source) for-loop [88] 100.0% -------------------------------------------------------------------- errors-score [26] 0.0% syntax-e/no-taint [13] 7.8% apply-transformer52 [85] 7.8% eval-const-expr [73] 7.8% ??? [38] 24.5% for-loop [33] 25.2% loop [87] 26.9% [87] 816(17.1%) 426(8.9%) loop (unknown source) loop [87] 26.9% sample-multi-bounded [89] 24.5% expand-capturing-lifts [82] 7.8% syntax-e [6] 7.8% gf [5] 7.8% -------------------------------------------------------------------- finish-bodys [86] 19.8% for-loop [88] 29.7% cache-or-reuse-hash [14] 50.5% [88] 376(7.9%) 190(4.0%) for-loop (unknown source) for-loop [88] 29.7% finish-bodys [86] 9.9% add-local-binding!39 [90] 9.9% -------------------------------------------------------------------- loop [87] 14.4% ??? [38] 85.6% [89] 1390(29.2%) 0(0.0%) sample-multi-bounded ...master/src/points.rkt:14:0 random-ranges [91] 100.0% -------------------------------------------------------------------- for-loop [88] 100.0% [90] 186(3.9%) 0(0.0%) add-local-binding!39 (unknown source) binding-table-add [92] 100.0% -------------------------------------------------------------------- sample-multi-bounded [89] 100.0% [91] 1390(29.2%) 200(4.2%) random-ranges ...erbie/master/src/common.rkt:164:0 cons/c [93] 58.1% build--> [94] 27.5% -------------------------------------------------------------------- add-local-binding!39 [90] 100.0% [92] 186(3.9%) 186(3.9%) binding-table-add (unknown source) -------------------------------------------------------------------- random-ranges [91] 100.0% [93] 808(17.0%) 200(4.2%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [95] 75.2% -------------------------------------------------------------------- random-ranges [91] 100.0% [94] 382(8.0%) 196(4.1%) build--> ...act/private/arrow-val-first.rkt:1214:0 coerce-contract [95] 48.7% -------------------------------------------------------------------- build--> [94] 23.4% cons/c [93] 76.6% [95] 794(16.7%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [96] 100.0% -------------------------------------------------------------------- coerce-contract [95] 100.0% [96] 794(16.7%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [97] 100.0% -------------------------------------------------------------------- coerce-contract/f [96] 100.0% [97] 794(16.7%) 794(16.7%) coerce-simple-value ...ract/private/guts.rkt:385:0 --------------------------------------------------------------------