Profiling results ----------------- Total cpu time observed: 4412ms (out of 4536ms) Number of samples taken: 24 (once every 184ms) ============================================================================ Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ============================================================================ [1] 4412(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [6] 100.0% ---------------------------------------------------------------------------- expand-capturing-lifts [88] 35.0% for-loop [91] 65.0% [2] 514(11.7%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [7] 100.0% ---------------------------------------------------------------------------- ??? [62] 100.0% [3] 338(7.7%) 0(0.0%) approximate9 ...h-actions/src/core/taylor.rkt:11:0 loop [8] 100.0% ---------------------------------------------------------------------------- ??? [62] 47.9% hash-ref! [67] 52.1% [4] 334(7.6%) 0(0.0%) f40 (unknown source) map [9] 100.0% ---------------------------------------------------------------------------- hash-ref! [67] 100.0% [5] 174(3.9%) 0(0.0%) ??? ...herbie/gh-actions/src/core/taylor.rkt:67:15 ??? [62] 100.0% ---------------------------------------------------------------------------- ??? [1] 100.0% [6] 4412(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [10] 100.0% ---------------------------------------------------------------------------- dispatch-transformer41 [2] 100.0% [7] 514(11.7%) 170(3.9%) apply-transformer52 (unknown source) loop [70] 35.0% apply-transformer-in-context [11] 31.9% ---------------------------------------------------------------------------- approximate9 [3] 100.0% [8] 338(7.7%) 0(0.0%) loop ...herbie/gh-actions/src/core/taylor.rkt:86:4 hash-ref! [67] 51.5% ??? [62] 48.5% ---------------------------------------------------------------------------- f40 [4] 100.0% [9] 334(7.6%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 parse-loop74 [71] 52.1% make-multiplication-node [12] 47.9% ---------------------------------------------------------------------------- profile-thunk16 [6] 100.0% [10] 4412(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [13] 100.0% ---------------------------------------------------------------------------- apply-transformer52 [7] 100.0% [11] 164(3.7%) 0(0.0%) apply-transformer-in-context (unknown source) go [14] 100.0% ---------------------------------------------------------------------------- map [9] 100.0% [12] 160(3.6%) 0(0.0%) make-multiplication-node .../core/reduce.rkt:231:0 make-multiplication-subnode [15] 100.0% ---------------------------------------------------------------------------- for-loop [73] 2.0% run [10] 98.0% [13] 4412(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [16] 49.2% prepare-points-intervals [17] 26.9% oracle-error [18] 12.1% get-final-combination [19] 6.3% errors [65] 3.5% ulp-difference [83] 2.0% ---------------------------------------------------------------------------- apply-transformer-in-context [11] 100.0% [14] 164(3.7%) 0(0.0%) go .../collects/racket/private/qq-and-or.rkt:50:20 loop [20] 100.0% ---------------------------------------------------------------------------- make-multiplication-node [12] 100.0% [15] 160(3.6%) 0(0.0%) make-multiplication-subnode ...re/reduce.rkt:241:0 for-loop [21] 100.0% ---------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 100.0% [16] 2170(49.2%) 0(0.0%) run-improve47 ...gh-actions/src/mainloop.rkt:365:0 for-loop [22] 100.0% ---------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 100.0% [17] 1188(26.9%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:122:0 loop [23] 100.0% ---------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 100.0% [18] 532(12.1%) 0(0.0%) oracle-error ...ie/gh-actions/src/points.rkt:179:0 for-loop [24] 100.0% ---------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 100.0% [19] 366(8.3%) 0(0.0%) get-final-combination ...ns/src/mainloop.rkt:390:0 ??? [25] 50.8% infer-splitpoints [26] 49.2% ---------------------------------------------------------------------------- loop [20] 50.0% go [14] 50.0% [20] 164(3.7%) 0(0.0%) loop ...llects/racket/private/qq-and-or.rkt:101:61 loop [20] 50.0% datum->syntax6 [27] 50.0% ---------------------------------------------------------------------------- make-multiplication-subnode [15] 100.0% [21] 160(3.6%) 0(0.0%) for-loop ...e/gh-actions/src/core/reduce.rkt:243:3 make-multiplication-subsubsubnode [28]100.0% ---------------------------------------------------------------------------- run-improve47 [16] 100.0% [22] 2170(49.2%) 0(0.0%) for-loop ...rbie/gh-actions/src/mainloop.rkt:384:4 run-iter! [29] 100.0% ---------------------------------------------------------------------------- prepare-points-intervals [17] 100.0% [23] 1188(26.9%) 0(0.0%) loop ...ies/herbie/gh-actions/src/points.rkt:134:4 loop [30] 73.1% ??? [31] 26.9% ---------------------------------------------------------------------------- oracle-error [18] 100.0% [24] 532(12.1%) 0(0.0%) for-loop ...herbie/gh-actions/src/points.rkt:180:2 loop [70] 100.0% ---------------------------------------------------------------------------- get-final-combination [19] 100.0% [25] 186(4.2%) 0(0.0%) ??? ...erbie/gh-actions/src/core/simplify.rkt:38:0 ??? [42] 100.0% ---------------------------------------------------------------------------- get-final-combination [19] 100.0% [26] 180(4.1%) 0(0.0%) infer-splitpoints ...ons/src/core/regimes.rkt:33:0 for-loop [32] 100.0% ---------------------------------------------------------------------------- loop [20] 100.0% [27] 164(3.7%) 0(0.0%) datum->syntax6 (unknown source) loop [70] 100.0% ---------------------------------------------------------------------------- for-loop [21] 100.0% [28] 160(3.6%) 0(0.0%) make-multiplication-subsubsubnode ...uce.rkt:263:0 mterm->expr [33] 100.0% ---------------------------------------------------------------------------- for-loop [22] 100.0% [29] 2170(49.2%) 0(0.0%) run-iter! ...bie/gh-actions/src/mainloop.rkt:346:0 simplify! [34] 53.0% gen-series! [35] 22.9% choose-best-alt! [36] 16.2% finalize-iter! [39] 7.8% ---------------------------------------------------------------------------- loop [23] 100.0% [30] 868(19.7%) 182(4.1%) loop ...lies/herbie/gh-actions/src/points.rkt:79:2 real->precision [37] 40.1% ??? [62] 19.6% ??? [79] 19.4% ---------------------------------------------------------------------------- loop [23] 100.0% [31] 320(7.3%) 154(3.5%) ??? ...lies/herbie/gh-actions/src/points.rkt:115:6 sample-multi-bounded [40] 51.9% ---------------------------------------------------------------------------- infer-splitpoints [26] 100.0% [32] 180(4.1%) 0(0.0%) for-loop ...e/gh-actions/src/core/regimes.rkt:45:6 option-on-expr [38] 100.0% ---------------------------------------------------------------------------- make-multiplication-subsubsubnode [28]100.0% [33] 160(3.6%) 0(0.0%) mterm->expr ...h-actions/src/core/reduce.rkt:271:0 type-of [41] 100.0% ---------------------------------------------------------------------------- run-iter! [29] 100.0% [34] 1150(26.1%) 0(0.0%) simplify! ...bie/gh-actions/src/mainloop.rkt:224:0 ??? [42] 100.0% ---------------------------------------------------------------------------- run-iter! [29] 100.0% [35] 498(11.3%) 0(0.0%) gen-series! ...e/gh-actions/src/mainloop.rkt:160:0 for-loop [43] 100.0% ---------------------------------------------------------------------------- run-iter! [29] 100.0% [36] 352(8.0%) 0(0.0%) choose-best-alt! ...actions/src/mainloop.rkt:117:0 ...ow-val-first.rkt:486:18 [46] 51.1% debug-print [47] 48.9% ---------------------------------------------------------------------------- loop [30] 100.0% [37] 348(7.9%) 0(0.0%) real->precision ...actions/src/programs.rkt:118:11 ??? [44] 53.4% ??? [62] 46.6% ---------------------------------------------------------------------------- for-loop [32] 100.0% [38] 180(4.1%) 0(0.0%) option-on-expr ...tions/src/core/regimes.rkt:124:0 for-loop [45] 100.0% ---------------------------------------------------------------------------- run-iter! [29] 100.0% [39] 170(3.9%) 0(0.0%) finalize-iter! ...h-actions/src/mainloop.rkt:278:0 ??? [48] 100.0% ---------------------------------------------------------------------------- ??? [31] 100.0% [40] 166(3.8%) 0(0.0%) sample-multi-bounded ...ctions/src/points.rkt:14:0 random-ranges [49] 100.0% ---------------------------------------------------------------------------- mterm->expr [33] 100.0% [41] 160(3.6%) 0(0.0%) type-of ...herbie/gh-actions/src/programs.rkt:39:0 variable? [50] 100.0% ---------------------------------------------------------------------------- ??? [25] 13.9% simplify! [34] 86.1% [42] 1336(30.3%) 0(0.0%) ??? ...erbie/gh-actions/src/core/simplify.rkt:42:0 egraph-run [51] 100.0% ---------------------------------------------------------------------------- gen-series! [35] 100.0% [43] 498(11.3%) 0(0.0%) for-loop ...rbie/gh-actions/src/mainloop.rkt:167:7 taylor-alt [52] 100.0% ---------------------------------------------------------------------------- real->precision [37] 100.0% [44] 186(4.2%) 0(0.0%) ??? ...ects/racket/contract/private/guts.rkt:770:8 bigvalue? [53] 100.0% ---------------------------------------------------------------------------- option-on-expr [38] 100.0% [45] 180(4.1%) 0(0.0%) for-loop .../gh-actions/src/core/regimes.rkt:135:4 errors [65] 100.0% ---------------------------------------------------------------------------- choose-best-alt! [36] 100.0% [46] 180(4.1%) 0(0.0%) ...ow-val-first.rkt:486:18 (unknown source) ??? [54] 100.0% ---------------------------------------------------------------------------- choose-best-alt! [36] 100.0% [47] 172(3.9%) 0(0.0%) debug-print ...rbie/gh-actions/src/debug.rkt:110:0 for-loop [55] 100.0% ---------------------------------------------------------------------------- finalize-iter! [39] 100.0% [48] 170(3.9%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [56] 100.0% ---------------------------------------------------------------------------- sample-multi-bounded [40] 100.0% [49] 166(3.8%) 166(3.8%) random-ranges ...e/gh-actions/src/common.rkt:164:0 ---------------------------------------------------------------------------- type-of [41] 100.0% [50] 160(3.6%) 160(3.6%) variable? ...h-actions/src/syntax/syntax.rkt:729:0 ---------------------------------------------------------------------------- ??? [42] 100.0% [51] 1336(30.3%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [57] 100.0% ---------------------------------------------------------------------------- for-loop [43] 100.0% [52] 498(11.3%) 0(0.0%) taylor-alt ...ie/gh-actions/src/mainloop.rkt:146:0 for-loop [58] 100.0% ---------------------------------------------------------------------------- ??? [44] 100.0% [53] 186(4.2%) 186(4.2%) bigvalue? .../gh-actions/src/syntax/types.rkt:19:0 ---------------------------------------------------------------------------- ...ow-val-first.rkt:486:18 [46] 100.0% [54] 180(4.1%) 0(0.0%) ??? ...rbie/gh-actions/src/core/alt-table.rkt:41:0 loop [59] 100.0% ---------------------------------------------------------------------------- debug-print [47] 100.0% [55] 172(3.9%) 172(3.9%) for-loop .../herbie/gh-actions/src/debug.rkt:116:2 ---------------------------------------------------------------------------- ??? [48] 100.0% [56] 170(3.9%) 0(0.0%) for-loop ...h-actions/src/core/alt-table.rkt:201:2 atab-add-altn [60] 100.0% ---------------------------------------------------------------------------- egraph-run [51] 100.0% [57] 1336(30.3%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [61] 86.1% loop [70] 13.9% ---------------------------------------------------------------------------- taylor-alt [52] 100.0% [58] 498(11.3%) 0(0.0%) for-loop ...rbie/gh-actions/src/mainloop.rkt:152:6 ??? [62] 100.0% ---------------------------------------------------------------------------- ??? [54] 100.0% [59] 180(4.1%) 0(0.0%) loop .../racket-7.5/collects/racket/list.rkt:751:4 ??? [63] 100.0% ---------------------------------------------------------------------------- for-loop [56] 100.0% [60] 170(3.9%) 0(0.0%) atab-add-altn ...ions/src/core/alt-table.rkt:204:0 errors [65] 100.0% ---------------------------------------------------------------------------- egraph-add-exprs [57] 100.0% [61] 1150(26.1%) 0(0.0%) ??? ...rbie/gh-actions/src/core/simplify.rkt:103:6 for-loop [64] 100.0% ---------------------------------------------------------------------------- loop [8] 6.6% ??? [5] 7.0% real->precision [37] 19.5% loop [30] 20.5% location-do [66] 23.2% for-loop [58] 23.2% [62] 830(18.8%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [66] 23.2% ival-mult [68] 20.5% bf [69] 19.5% approximate9 [3] 13.6% hash-ref! [67] 13.6% f40 [4] 9.6% ---------------------------------------------------------------------------- loop [59] 100.0% [63] 180(4.1%) 0(0.0%) ??? ...s/herbie/gh-actions/src/mainloop.rkt:114:10 errors [65] 100.0% ---------------------------------------------------------------------------- ??? [61] 100.0% [64] 1150(26.1%) 1150(26.1%) for-loop ...gh-actions/src/core/simplify.rkt:121:2 ---------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 22.7% atab-add-altn [60] 24.8% ??? [63] 26.2% for-loop [45] 26.2% [65] 686(15.5%) 0(0.0%) errors ...s/herbie/gh-actions/src/points.rkt:192:0 for-loop [73] 49.0% loop [70] 26.2% temp85_0 [74] 24.8% ---------------------------------------------------------------------------- location-do [66] 17.5% ??? [62] 82.5% [66] 498(11.3%) 0(0.0%) location-do ...ie/gh-actions/src/programs.rkt:87:0 ??? [62] 82.5% location-do [66] 17.5% ---------------------------------------------------------------------------- ??? [75] 12.9% loop [8] 12.9% ??? [72] 37.1% ??? [62] 37.1% [67] 338(7.7%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [72] 37.1% parse-loop74 [71] 24.3% ??? [5] 12.9% ??? [75] 12.9% f40 [4] 12.9% ---------------------------------------------------------------------------- ??? [62] 100.0% [68] 170(3.9%) 0(0.0%) ival-mult .../gh-actions/src/biginterval.rkt:129:0 bfmul [76] 100.0% ---------------------------------------------------------------------------- ??? [62] 100.0% [69] 162(3.7%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [77] 100.0% ---------------------------------------------------------------------------- datum->syntax6 [27] 7.7% apply-transformer52 [7] 8.5% errors [65] 8.5% egraph-add-exprs [57] 17.5% for-loop [24] 25.8% loop [70] 32.0% [70] 1062(24.1%) 350(7.9%) loop (unknown source) loop [70] 32.0% ??? [78] 25.8% expand-capturing-lifts [88] 8.5% core-form-sym [81] 8.5% ---------------------------------------------------------------------------- hash-ref! [67] 48.5% map [9] 51.5% [71] 338(7.7%) 174(3.9%) parse-loop74 (unknown source) eval-const-expr [82] 48.5% ---------------------------------------------------------------------------- hash-ref! [67] 100.0% [72] 338(7.7%) 0(0.0%) ??? ...herbie/gh-actions/src/core/taylor.rkt:44:15 hash-ref! [67] 100.0% ---------------------------------------------------------------------------- errors [65] 100.0% [73] 336(7.6%) 156(3.5%) for-loop ...herbie/gh-actions/src/points.rkt:194:2 .../more-scheme.rkt:261:28 [13] 53.6% ---------------------------------------------------------------------------- eval-const-expr [82] 49.1% errors [65] 50.9% [74] 334(7.6%) 0(0.0%) temp85_0 (unknown source) compile15 [80] 100.0% ---------------------------------------------------------------------------- hash-ref! [67] 100.0% [75] 174(3.9%) 0(0.0%) ??? ...erbie/gh-actions/src/core/taylor.rkt:343:33 hash-ref! [67] 100.0% ---------------------------------------------------------------------------- ival-mult [68] 100.0% [76] 170(3.9%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [79] 100.0% ---------------------------------------------------------------------------- bf [69] 100.0% [77] 162(3.7%) 162(3.7%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ---------------------------------------------------------------------------- loop [70] 100.0% [78] 532(12.1%) 348(7.9%) ??? ...ies/herbie/gh-actions/src/points.rkt:181:26 ulp-difference [83] 34.6% ---------------------------------------------------------------------------- loop [30] 49.7% bfmul [76] 50.3% [79] 338(7.7%) 338(7.7%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ---------------------------------------------------------------------------- temp85_0 [74] 100.0% [80] 334(7.6%) 0(0.0%) compile15 (unknown source) temp91_0 [84] 100.0% ---------------------------------------------------------------------------- loop [70] 100.0% [81] 180(4.1%) 0(0.0%) core-form-sym (unknown source) resolve+shift28 [85] 100.0% ---------------------------------------------------------------------------- parse-loop74 [71] 100.0% [82] 164(3.7%) 0(0.0%) eval-const-expr ...-actions/src/programs.rkt:144:0 temp85_0 [74] 100.0% ---------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 49.5% ??? [78] 50.5% [83] 364(8.3%) 364(8.3%) ulp-difference ...ie/gh-actions/src/float.rkt:19:0 ---------------------------------------------------------------------------- compile15 [80] 100.0% [84] 334(7.6%) 0(0.0%) temp91_0 (unknown source) temp118_0 [86] 100.0% ---------------------------------------------------------------------------- core-form-sym [81] 100.0% [85] 180(4.1%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [87] 100.0% ---------------------------------------------------------------------------- temp91_0 [84] 100.0% [86] 334(7.6%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [88] 100.0% ---------------------------------------------------------------------------- resolve+shift28 [85] 100.0% [87] 180(4.1%) 0(0.0%) fallback-loop (unknown source) for-loop [91] 100.0% ---------------------------------------------------------------------------- loop [70] 35.0% temp118_0 [86] 65.0% [88] 514(11.7%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [89] 65.0% dispatch-transformer41 [2] 35.0% ---------------------------------------------------------------------------- expand-capturing-lifts [88] 100.0% [89] 334(7.6%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [90] 100.0% ---------------------------------------------------------------------------- lambda-clause-expander [89] 30.2% for-loop [91] 69.8% [90] 334(7.6%) 0(0.0%) finish-bodys (unknown source) for-loop [91] 100.0% ---------------------------------------------------------------------------- fallback-loop [87] 17.5% for-loop [91] 34.2% finish-bodys [90] 48.3% [91] 514(11.7%) 180(4.1%) for-loop (unknown source) finish-bodys [90] 34.7% for-loop [91] 34.2% dispatch-transformer41 [2] 13.6% ----------------------------------------------------------------------------