Profiling results ----------------- Total cpu time observed: 10148ms (out of 10280ms) Number of samples taken: 49 (once every 207ms) ========================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================== [1] 10148(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [14] 100.0% -------------------------------------------------------------------------- ??? [77] 100.0% [2] 4378(43.1%) 0(0.0%) approximate9 ...ie/master/src/core/taylor.rkt:11:0 loop [15] 100.0% -------------------------------------------------------------------------- map [93] 13.8% hash-ref! [87] 86.2% [3] 2978(29.3%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [16] 100.0% -------------------------------------------------------------------------- hash-ref! [87] 100.0% [4] 1928(19.0%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:509:23 for-loop [17] 100.0% -------------------------------------------------------------------------- hash-ref! [87] 100.0% [5] 1454(14.3%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:290:26 for-loop [19] 100.0% -------------------------------------------------------------------------- for-loop [66] 100.0% [6] 1286(12.7%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [18] 100.0% -------------------------------------------------------------------------- hash-ref! [87] 100.0% [7] 868(8.6%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:300:23 for-loop [21] 100.0% -------------------------------------------------------------------------- for-loop [66] 100.0% [8] 652(6.4%) 0(0.0%) expand-implicit (unknown source) resolve+shift28 [20] 100.0% -------------------------------------------------------------------------- map [93] 100.0% [9] 402(4.0%) 0(0.0%) simplify-node ...e/master/src/core/reduce.rkt:46:0 gather-multiplicative-terms [95] 100.0% -------------------------------------------------------------------------- map [93] 49.7% loop [97] 50.3% [10] 398(3.9%) 0(0.0%) f61 (unknown source) composed [22] 50.3% eval-const-expr [16] 49.7% -------------------------------------------------------------------------- hash-ref! [87] 100.0% [11] 222(2.2%) 0(0.0%) ??? ...htlies/herbie/master/src/programs.rkt:178:5 loop [97] 100.0% -------------------------------------------------------------------------- for-loop [66] 100.0% [12] 202(2.0%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [20] 100.0% -------------------------------------------------------------------------- map [93] 100.0% [13] 200(2.0%) 0(0.0%) loop ...-7.5/collects/racket/private/map.rkt:40:19 f40 [92] 100.0% -------------------------------------------------------------------------- ??? [1] 100.0% [14] 10148(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [23] 100.0% -------------------------------------------------------------------------- approximate9 [2] 100.0% [15] 4378(43.1%) 0(0.0%) loop ...ies/herbie/master/src/core/taylor.rkt:86:4 ??? [77] 100.0% -------------------------------------------------------------------------- f61 [10] 6.2% parse-loop74 [3] 93.8% [16] 3176(31.3%) 0(0.0%) eval-const-expr ...e/master/src/programs.rkt:120:0 temp85_0 [24] 100.0% -------------------------------------------------------------------------- ??? [4] 100.0% [17] 1928(19.0%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:513:35 parse-loop402 [25] 100.0% -------------------------------------------------------------------------- expand-id-application-form17 [101] 23.7% syntax-e [6] 76.3% [18] 1686(16.6%) 0(0.0%) syntax-e/no-taint (unknown source) loop [97] 100.0% -------------------------------------------------------------------------- ??? [5] 100.0% [19] 1454(14.3%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:290:52 ??? [27] 58.5% hash-ref! [87] 41.5% -------------------------------------------------------------------------- expand-id-application-form17 [101] 18.8% expand-identifier [12] 19.2% expand-implicit [8] 62.0% [20] 1052(10.4%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [26] 100.0% -------------------------------------------------------------------------- ??? [7] 100.0% [21] 868(8.6%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:303:27 hash-ref! [87] 100.0% -------------------------------------------------------------------------- f61 [10] 100.0% [22] 200(2.0%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 free-variables [28] 100.0% -------------------------------------------------------------------------- profile-thunk16 [14] 100.0% [23] 10148(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [29] 100.0% -------------------------------------------------------------------------- eval-const-expr [16] 100.0% [24] 3176(31.3%) 0(0.0%) temp85_0 (unknown source) compile15 [30] 100.0% -------------------------------------------------------------------------- for-loop [17] 100.0% [25] 1928(19.0%) 0(0.0%) parse-loop402 (unknown source) for-loop [31] 100.0% -------------------------------------------------------------------------- resolve+shift28 [20] 100.0% [26] 1052(10.4%) 632(6.2%) fallback-loop (unknown source) for-loop [66] 39.9% -------------------------------------------------------------------------- for-loop [19] 100.0% [27] 850(8.4%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:293:19 hash-ref! [87] 100.0% -------------------------------------------------------------------------- composed [22] 16.7% append-map [32] 83.3% [28] 200(2.0%) 200(2.0%) free-variables ...bie/master/src/programs.rkt:56:0 append-map [32] 83.3% -------------------------------------------------------------------------- for-loop [82] 2.9% run [23] 97.1% [29] 10148(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [33] 51.1% prepare-points-intervals [34] 38.1% errors [78] 3.9% ??? [104] 2.9% oracle-error [37] 2.0% get-final-combination [36] 2.0% -------------------------------------------------------------------------- temp85_0 [24] 100.0% [30] 3176(31.3%) 0(0.0%) compile15 (unknown source) temp91_0 [35] 100.0% -------------------------------------------------------------------------- parse-loop402 [25] 100.0% [31] 1928(19.0%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:516:59 hash-ref! [87] 100.0% -------------------------------------------------------------------------- free-variables [28] 100.0% [32] 200(2.0%) 0(0.0%) append-map ...t-7.5/collects/racket/list.rkt:586:2 free-variables [28] 100.0% -------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [29] 100.0% [33] 5288(52.1%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:346:0 for-loop [38] 100.0% -------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [29] 100.0% [34] 3864(38.1%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:120:0 loop [39] 100.0% -------------------------------------------------------------------------- compile15 [30] 100.0% [35] 3176(31.3%) 0(0.0%) temp91_0 (unknown source) temp118_0 [40] 100.0% -------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [29] 100.0% [36] 200(2.0%) 0(0.0%) get-final-combination ...er/src/mainloop.rkt:371:0 infer-splitpoints [41] 100.0% -------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [29] 100.0% [37] 200(2.0%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:177:0 for-loop [42] 100.0% -------------------------------------------------------------------------- run-improve47 [33] 100.0% [38] 5288(52.1%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:365:4 run-iter! [43] 100.0% -------------------------------------------------------------------------- prepare-points-intervals [34] 100.0% [39] 3864(38.1%) 806(7.9%) loop ...ghtlies/herbie/master/src/points.rkt:132:4 loop [45] 47.3% ??? [46] 31.9% -------------------------------------------------------------------------- temp91_0 [35] 100.0% [40] 3176(31.3%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [44] 100.0% -------------------------------------------------------------------------- get-final-combination [36] 100.0% [41] 200(2.0%) 0(0.0%) infer-splitpoints ...ter/src/core/regimes.rkt:33:0 for-loop [47] 100.0% -------------------------------------------------------------------------- oracle-error [37] 100.0% [42] 200(2.0%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:178:2 loop [97] 100.0% -------------------------------------------------------------------------- for-loop [38] 100.0% [43] 5288(52.1%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:327:0 gen-series! [48] 82.8% simplify! [52] 9.2% finalize-iter! [53] 8.0% -------------------------------------------------------------------------- temp118_0 [40] 100.0% [44] 3176(31.3%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [49] 100.0% -------------------------------------------------------------------------- loop [39] 100.0% [45] 1826(18.0%) 206(2.0%) loop ...ightlies/herbie/master/src/points.rkt:79:2 ??? [50] 54.8% hash-update! [54] 11.9% ??? [61] 11.1% real->precision [56] 11.0% -------------------------------------------------------------------------- loop [39] 100.0% [46] 1232(12.1%) 400(3.9%) ??? ...ightlies/herbie/master/src/points.rkt:113:6 sample-multi-bounded [51] 67.5% -------------------------------------------------------------------------- infer-splitpoints [41] 100.0% [47] 200(2.0%) 0(0.0%) for-loop ...erbie/master/src/core/regimes.rkt:45:6 option-on-expr [55] 100.0% -------------------------------------------------------------------------- run-iter! [43] 100.0% [48] 4378(43.1%) 0(0.0%) gen-series! ...erbie/master/src/mainloop.rkt:160:0 for-loop [57] 100.0% -------------------------------------------------------------------------- expand-capturing-lifts [44] 100.0% [49] 3176(31.3%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [58] 100.0% -------------------------------------------------------------------------- loop [45] 100.0% [50] 1000(9.9%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-log [60] 80.0% ival-sub [63] 20.0% -------------------------------------------------------------------------- ??? [46] 100.0% [51] 832(8.2%) 0(0.0%) sample-multi-bounded ...master/src/points.rkt:14:0 random-ranges [59] 100.0% -------------------------------------------------------------------------- run-iter! [43] 100.0% [52] 488(4.8%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:224:0 ??? [62] 100.0% -------------------------------------------------------------------------- run-iter! [43] 100.0% [53] 422(4.2%) 0(0.0%) finalize-iter! ...ie/master/src/mainloop.rkt:278:0 ??? [61] 100.0% -------------------------------------------------------------------------- loop [45] 100.0% [54] 218(2.1%) 218(2.1%) hash-update! ...cket/private/more-scheme.rkt:365:4 -------------------------------------------------------------------------- for-loop [47] 100.0% [55] 200(2.0%) 0(0.0%) option-on-expr ...aster/src/core/regimes.rkt:124:0 sort-context-on-expr [64] 100.0% -------------------------------------------------------------------------- loop [45] 100.0% [56] 200(2.0%) 0(0.0%) real->precision ...e/master/src/programs.rkt:94:11 ??? [77] 100.0% -------------------------------------------------------------------------- gen-series! [48] 100.0% [57] 4378(43.1%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:167:7 taylor-alt [65] 100.0% -------------------------------------------------------------------------- lambda-clause-expander [49] 7.3% for-loop [66] 92.7% [58] 3176(31.3%) 0(0.0%) finish-bodys (unknown source) for-loop [66] 100.0% -------------------------------------------------------------------------- sample-multi-bounded [51] 100.0% [59] 832(8.2%) 0(0.0%) random-ranges ...erbie/master/src/common.rkt:164:0 build--> [68] 51.7% cons/c [70] 48.3% -------------------------------------------------------------------------- ??? [50] 100.0% [60] 800(7.9%) 800(7.9%) ival-log ...erbie/master/src/biginterval.rkt:202:0 -------------------------------------------------------------------------- loop [45] 32.4% finalize-iter! [53] 67.6% [61] 624(6.1%) 202(2.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [69] 67.6% -------------------------------------------------------------------------- simplify! [52] 100.0% [62] 488(4.8%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:42:0 egraph-run [67] 100.0% -------------------------------------------------------------------------- ??? [50] 100.0% [63] 200(2.0%) 200(2.0%) ival-sub ...erbie/master/src/biginterval.rkt:108:0 -------------------------------------------------------------------------- option-on-expr [55] 100.0% [64] 200(2.0%) 0(0.0%) sort-context-on-expr ...src/core/regimes.rkt:117:0 ??? [71] 100.0% -------------------------------------------------------------------------- for-loop [57] 100.0% [65] 4378(43.1%) 0(0.0%) taylor-alt ...herbie/master/src/mainloop.rkt:146:0 for-loop [72] 100.0% -------------------------------------------------------------------------- fallback-loop [26] 0.2% for-loop [66] 7.9% finish-bodys [58] 91.9% [66] 3176(31.3%) 858(8.5%) for-loop (unknown source) finish-bodys [58] 86.0% for-loop [66] 7.9% loop [97] 2.4% syntax-e [6] 1.3% expand-implicit [8] 0.3% expand-identifier [12] 0.1% -------------------------------------------------------------------------- ??? [62] 100.0% [67] 488(4.8%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [73] 100.0% -------------------------------------------------------------------------- random-ranges [59] 100.0% [68] 430(4.2%) 430(4.2%) build--> ...act/private/arrow-val-first.rkt:1214:0 -------------------------------------------------------------------------- ??? [61] 100.0% [69] 422(4.2%) 0(0.0%) for-loop ...bie/master/src/core/alt-table.rkt:46:2 atab-add-altn [74] 52.6% errors [78] 47.4% -------------------------------------------------------------------------- random-ranges [59] 100.0% [70] 402(4.0%) 200(2.0%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [75] 50.2% -------------------------------------------------------------------------- sort-context-on-expr [64] 100.0% [71] 200(2.0%) 0(0.0%) ??? ...-7.5/collects/racket/private/sort.rkt:369:3 generic-sort/key [76] 100.0% -------------------------------------------------------------------------- taylor-alt [65] 100.0% [72] 4378(43.1%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:152:6 ??? [77] 100.0% -------------------------------------------------------------------------- egraph-run [67] 100.0% [73] 488(4.8%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [79] 100.0% -------------------------------------------------------------------------- for-loop [69] 100.0% [74] 222(2.2%) 0(0.0%) atab-add-altn ...ster/src/core/alt-table.rkt:194:0 errors [78] 100.0% -------------------------------------------------------------------------- cons/c [70] 100.0% [75] 202(2.0%) 202(2.0%) coerce-contract ...contract/private/guts.rkt:307:0 -------------------------------------------------------------------------- ??? [71] 100.0% [76] 200(2.0%) 0(0.0%) generic-sort/key .../racket/private/sort.rkt:156:2 copying-mergesort [80] 100.0% -------------------------------------------------------------------------- real->precision [56] 4.4% loop [15] 31.9% location-do [81] 31.9% for-loop [72] 31.9% [77] 4578(45.1%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [81] 31.9% approximate9 [2] 31.9% hash-ref! [87] 31.9% bf [85] 4.4% -------------------------------------------------------------------------- for-loop [69] 19.6% atab-add-altn [74] 21.8% .../more-scheme.rkt:261:28 [29] 58.5% [78] 1018(10.0%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:190:0 for-loop [82] 78.2% eval-prog [84] 21.8% -------------------------------------------------------------------------- egraph-add-exprs [73] 100.0% [79] 488(4.8%) 0(0.0%) ??? ...s/herbie/master/src/core/simplify.rkt:102:6 for-loop [83] 100.0% -------------------------------------------------------------------------- generic-sort/key [76] 25.0% copying-mergesort [80] 75.0% [80] 200(2.0%) 0(0.0%) copying-mergesort ...racket/private/sort.rkt:129:8 copying-mergesort [80] 75.0% jloop [86] 25.0% -------------------------------------------------------------------------- location-do [81] 19.3% ??? [77] 80.7% [81] 4378(43.1%) 0(0.0%) location-do ...herbie/master/src/programs.rkt:63:0 ??? [77] 80.7% location-do [81] 19.3% -------------------------------------------------------------------------- errors [78] 100.0% [82] 796(7.8%) 200(2.0%) for-loop ...ies/herbie/master/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [29] 74.9% -------------------------------------------------------------------------- ??? [79] 100.0% [83] 488(4.8%) 488(4.8%) for-loop ...bie/master/src/core/simplify.rkt:121:2 -------------------------------------------------------------------------- errors [78] 100.0% [84] 222(2.2%) 0(0.0%) eval-prog ...s/herbie/master/src/programs.rkt:82:0 hash-ref! [87] 100.0% -------------------------------------------------------------------------- ??? [77] 100.0% [85] 200(2.0%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [88] 100.0% -------------------------------------------------------------------------- copying-mergesort [80] 100.0% [86] 200(2.0%) 0(0.0%) jloop ...5/collects/racket/private/sort.rkt:120:23 ??? [104] 100.0% -------------------------------------------------------------------------- simplify* [98] 1.1% eval-prog [84] 1.2% ??? [90] 2.2% ??? [91] 3.6% loop [97] 3.6% for-loop [21] 4.2% for-loop [19] 4.4% ??? [27] 5.0% for-loop [31] 11.2% ??? [89] 31.8% ??? [77] 31.8% [87] 4600(45.3%) 422(4.2%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [89] 31.8% parse-loop74 [3] 15.4% f40 [92] 14.2% ??? [4] 11.2% ??? [5] 9.4% ??? [90] 4.3% ??? [7] 4.2% ??? [11] 3.6% ??? [91] 3.6% -------------------------------------------------------------------------- bf [85] 100.0% [88] 200(2.0%) 200(2.0%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 -------------------------------------------------------------------------- hash-ref! [87] 100.0% [89] 4378(43.1%) 0(0.0%) ??? ...ies/herbie/master/src/core/taylor.rkt:44:15 hash-ref! [87] 100.0% -------------------------------------------------------------------------- hash-ref! [87] 100.0% [90] 646(6.4%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:343:33 hash-ref! [87] 69.0% f40 [92] 31.0% -------------------------------------------------------------------------- hash-ref! [87] 100.0% [91] 632(6.2%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:327:33 hash-ref! [87] 100.0% -------------------------------------------------------------------------- parse-loop49 [94] 3.6% ??? [90] 5.5% loop [13] 5.5% loop [97] 5.9% map [93] 26.9% hash-ref! [87] 52.5% [92] 1810(17.8%) 0(0.0%) f40 (unknown source) map [93] 100.0% -------------------------------------------------------------------------- gather-multiplicative-terms [95] 2.8% parse-loop49 [94] 3.7% f40 [92] 93.5% [93] 1810(17.8%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 parse-loop49 [94] 35.3% f40 [92] 25.1% parse-loop74 [3] 15.3% simplify-node [9] 6.5% ??? [96] 5.5% loop [13] 3.7% f61 [10] 3.6% gather-multiplicative-terms [95] 2.8% simplify* [98] 2.2% -------------------------------------------------------------------------- map [93] 100.0% [94] 1198(11.8%) 0(0.0%) parse-loop49 (unknown source) loop [97] 50.1% map [93] 16.7% simplify* [98] 16.7% f40 [92] 16.5% -------------------------------------------------------------------------- map [93] 25.1% simplify-node [9] 74.9% [95] 402(4.0%) 202(2.0%) gather-multiplicative-terms ...re/reduce.rkt:110:0 do-curry [99] 49.8% map [93] 25.1% -------------------------------------------------------------------------- map [93] 100.0% [96] 200(2.0%) 200(2.0%) ??? ...lies/herbie/master/src/core/reduce.rkt:57:5 -------------------------------------------------------------------------- for-loop [42] 7.4% parse-loop49 [94] 8.0% ??? [11] 8.2% loop [97] 12.3% for-loop [66] 14.7% syntax-e/no-taint [18] 49.4% [97] 2706(26.7%) 0(0.0%) loop (unknown source) gf [100] 49.4% expand-id-application-form17 [101] 14.7% loop [97] 12.3% hash-ref! [87] 8.2% ??? [102] 7.4% f40 [92] 5.5% f61 [10] 2.5% -------------------------------------------------------------------------- parse-loop49 [94] 50.0% map [93] 50.0% [98] 400(3.9%) 200(2.0%) simplify* ...erbie/master/src/core/reduce.rkt:29:0 hash-ref! [87] 50.0% -------------------------------------------------------------------------- gather-multiplicative-terms [95] 100.0% [99] 200(2.0%) 200(2.0%) do-curry ...-7.5/collects/racket/function.rkt:71:2 -------------------------------------------------------------------------- loop [97] 100.0% [100] 1686(16.6%) 0(0.0%) gf (unknown source) propagation-apply [103] 87.9% propagation-apply-shifted [105] 12.1% -------------------------------------------------------------------------- loop [97] 100.0% [101] 598(5.9%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [18] 66.9% resolve+shift28 [20] 33.1% -------------------------------------------------------------------------- loop [97] 100.0% [102] 200(2.0%) 0(0.0%) ??? ...ghtlies/herbie/master/src/points.rkt:179:26 ??? [104] 100.0% -------------------------------------------------------------------------- gf [100] 100.0% [103] 1482(14.6%) 1482(14.6%) propagation-apply (unknown source) -------------------------------------------------------------------------- jloop [86] 20.1% ??? [102] 20.1% .../more-scheme.rkt:261:28 [29] 59.8% [104] 996(9.8%) 996(9.8%) ??? .../herbie/master/src/syntax/syntax.rkt:214:17 -------------------------------------------------------------------------- gf [100] 100.0% [105] 204(2.0%) 204(2.0%) propagation-apply-shifted (unknown source) --------------------------------------------------------------------------