Profiling results ----------------- Total cpu time observed: 5776ms (out of 5904ms) Number of samples taken: 27 (once every 214ms) ==================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ==================================================================== [1] 5776(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 100.0% -------------------------------------------------------------------- matcher [75] 100.0% [2] 206(3.6%) 0(0.0%) ??? ...rbie/gh-actions/src/core/matcher.rkt:129:11 for-loop [4] 100.0% -------------------------------------------------------------------- ??? [1] 100.0% [3] 5776(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% -------------------------------------------------------------------- ??? [2] 100.0% [4] 206(3.6%) 0(0.0%) for-loop ...gh-actions/src/core/matcher.rkt:131:15 hash-ref! [69] 100.0% -------------------------------------------------------------------- profile-thunk16 [3] 100.0% [5] 5776(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 [63] 5.5% run [5] 94.5% [6] 5776(100.0%) 208(3.6%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [7] 47.9% prepare-points-intervals [8] 26.8% oracle-error [9] 7.3% errors [56] 5.7% for-loop [12] 3.5% get-final-combination [13] 3.4% ulp-difference [10] 1.9% ordinary-value? [11] 1.8% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [7] 2976(51.5%) 0(0.0%) run-improve47 ...gh-actions/src/mainloop.rkt:365:0 for-loop [14] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [8] 1550(26.8%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:133:0 loop [15] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [9] 422(7.3%) 0(0.0%) oracle-error ...ie/gh-actions/src/points.rkt:190:0 for-loop [16] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [10] 216(3.7%) 216(3.7%) ulp-difference ...ie/gh-actions/src/float.rkt:19:0 -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [11] 206(3.6%) 0(0.0%) ordinary-value? ...e/gh-actions/src/float.rkt:51:0 list-member? [17] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [12] 202(3.5%) 202(3.5%) for-loop ...herbie/gh-actions/src/sandbox.rkt:69:8 -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [13] 194(3.4%) 0(0.0%) get-final-combination ...ns/src/mainloop.rkt:390:0 infer-splitpoints [18] 100.0% -------------------------------------------------------------------- run-improve47 [7] 100.0% [14] 2976(51.5%) 0(0.0%) for-loop ...rbie/gh-actions/src/mainloop.rkt:384:4 run-iter! [19] 100.0% -------------------------------------------------------------------- prepare-points-intervals [8] 100.0% [15] 1550(26.8%) 0(0.0%) loop ...ies/herbie/gh-actions/src/points.rkt:145:4 loop [20] 62.3% ??? [21] 37.7% -------------------------------------------------------------------- oracle-error [9] 100.0% [16] 422(7.3%) 0(0.0%) for-loop ...herbie/gh-actions/src/points.rkt:191:2 loop [22] 100.0% -------------------------------------------------------------------- ordinary-value? [11] 100.0% [17] 206(3.6%) 206(3.6%) list-member? ...llects/racket/private/set.rkt:24:0 -------------------------------------------------------------------- get-final-combination [13] 100.0% [18] 194(3.4%) 0(0.0%) infer-splitpoints ...ons/src/core/regimes.rkt:33:0 for-loop [23] 100.0% -------------------------------------------------------------------- for-loop [14] 100.0% [19] 2976(51.5%) 0(0.0%) run-iter! ...bie/gh-actions/src/mainloop.rkt:346:0 simplify! [24] 43.2% finalize-iter! [25] 35.0% gen-series! [27] 14.9% gen-rewrites! [29] 6.9% -------------------------------------------------------------------- loop [15] 100.0% [20] 966(16.7%) 0(0.0%) loop ...lies/herbie/gh-actions/src/points.rkt:81:2 ??? [57] 59.2% ??? [30] 20.7% real->precision [32] 20.1% -------------------------------------------------------------------- loop [15] 100.0% [21] 584(10.1%) 0(0.0%) ??? ...lies/herbie/gh-actions/src/points.rkt:126:6 sample-multi-bounded [26] 100.0% -------------------------------------------------------------------- for-loop [16] 42.1% loop [22] 57.9% [22] 422(7.3%) 0(0.0%) loop (unknown source) loop [22] 57.9% ??? [28] 42.1% -------------------------------------------------------------------- infer-splitpoints [18] 100.0% [23] 194(3.4%) 0(0.0%) for-loop ...e/gh-actions/src/core/regimes.rkt:45:6 option-on-expr [31] 100.0% -------------------------------------------------------------------- run-iter! [19] 100.0% [24] 1286(22.3%) 0(0.0%) simplify! ...bie/gh-actions/src/mainloop.rkt:224:0 ??? [33] 100.0% -------------------------------------------------------------------- run-iter! [19] 100.0% [25] 1042(18.0%) 0(0.0%) finalize-iter! ...h-actions/src/mainloop.rkt:278:0 ??? [34] 100.0% -------------------------------------------------------------------- ??? [21] 100.0% [26] 584(10.1%) 0(0.0%) sample-multi-bounded ...ctions/src/points.rkt:14:0 random-ranges [35] 100.0% -------------------------------------------------------------------- run-iter! [19] 100.0% [27] 442(7.7%) 0(0.0%) gen-series! ...e/gh-actions/src/mainloop.rkt:160:0 for-loop [36] 100.0% -------------------------------------------------------------------- loop [22] 100.0% [28] 422(7.3%) 222(3.8%) ??? ...ies/herbie/gh-actions/src/points.rkt:192:26 *bit-width* [39] 47.4% -------------------------------------------------------------------- run-iter! [19] 100.0% [29] 206(3.6%) 0(0.0%) gen-rewrites! ...gh-actions/src/mainloop.rkt:183:0 for-loop [37] 100.0% -------------------------------------------------------------------- loop [20] 100.0% [30] 200(3.5%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-sub [38] 100.0% -------------------------------------------------------------------- for-loop [23] 100.0% [31] 194(3.4%) 0(0.0%) option-on-expr ...tions/src/core/regimes.rkt:124:0 sort-context-on-expr [40] 100.0% -------------------------------------------------------------------- loop [20] 100.0% [32] 194(3.4%) 0(0.0%) real->precision ...actions/src/programs.rkt:118:11 ??? [57] 100.0% -------------------------------------------------------------------- simplify! [24] 100.0% [33] 1286(22.3%) 0(0.0%) ??? ...erbie/gh-actions/src/core/simplify.rkt:42:0 egraph-run [41] 100.0% -------------------------------------------------------------------- finalize-iter! [25] 100.0% [34] 1042(18.0%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [42] 100.0% -------------------------------------------------------------------- sample-multi-bounded [26] 100.0% [35] 584(10.1%) 0(0.0%) random-ranges ...e/gh-actions/src/common.rkt:164:0 cons/c [44] 65.8% build--> [47] 34.2% -------------------------------------------------------------------- gen-series! [27] 100.0% [36] 442(7.7%) 0(0.0%) for-loop ...rbie/gh-actions/src/mainloop.rkt:167:7 taylor-alt [43] 100.0% -------------------------------------------------------------------- gen-rewrites! [29] 100.0% [37] 206(3.6%) 0(0.0%) for-loop ...bie/gh-actions/src/mainloop.rkt:191:11 rewrite-expression-head23 [45]100.0% -------------------------------------------------------------------- ??? [30] 100.0% [38] 200(3.5%) 200(3.5%) ival-sub ...e/gh-actions/src/biginterval.rkt:195:0 -------------------------------------------------------------------- ??? [28] 100.0% [39] 200(3.5%) 0(0.0%) *bit-width* ...erbie/gh-actions/src/float.rkt:34:0 return/no-unsupplied [46] 100.0% -------------------------------------------------------------------- option-on-expr [31] 100.0% [40] 194(3.4%) 0(0.0%) sort-context-on-expr ...src/core/regimes.rkt:117:0 ??? [48] 100.0% -------------------------------------------------------------------- ??? [33] 100.0% [41] 1286(22.3%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [49] 100.0% -------------------------------------------------------------------- ??? [34] 100.0% [42] 1042(18.0%) 0(0.0%) for-loop ...h-actions/src/core/alt-table.rkt:201:2 atab-add-altn [50] 100.0% -------------------------------------------------------------------- for-loop [36] 100.0% [43] 442(7.7%) 0(0.0%) taylor-alt ...ie/gh-actions/src/mainloop.rkt:146:0 for-loop [52] 100.0% -------------------------------------------------------------------- random-ranges [35] 100.0% [44] 384(6.6%) 0(0.0%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [51] 100.0% -------------------------------------------------------------------- for-loop [37] 100.0% [45] 206(3.6%) 0(0.0%) rewrite-expression-head23 ...core/matcher.rkt:83:0 rewriter [53] 100.0% -------------------------------------------------------------------- *bit-width* [39] 100.0% [46] 200(3.5%) 200(3.5%) return/no-unsupplied ...ct/private/arr-i.rkt:566:0 -------------------------------------------------------------------- random-ranges [35] 100.0% [47] 200(3.5%) 0(0.0%) build--> ...act/private/arrow-val-first.rkt:1214:0 coerce-contract [51] 100.0% -------------------------------------------------------------------- sort-context-on-expr [40] 100.0% [48] 194(3.4%) 0(0.0%) ??? ...-7.5/collects/racket/private/sort.rkt:369:3 generic-sort/key [54] 100.0% -------------------------------------------------------------------- egraph-run [41] 100.0% [49] 1286(22.3%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [55] 100.0% -------------------------------------------------------------------- for-loop [42] 100.0% [50] 1042(18.0%) 0(0.0%) atab-add-altn ...ions/src/core/alt-table.rkt:204:0 errors [56] 80.8% best-and-tied-at-points [60] 19.2% -------------------------------------------------------------------- build--> [47] 34.2% cons/c [44] 65.8% [51] 584(10.1%) 200(3.5%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [58] 65.8% -------------------------------------------------------------------- taylor-alt [43] 100.0% [52] 442(7.7%) 0(0.0%) for-loop ...rbie/gh-actions/src/mainloop.rkt:152:6 ??? [57] 100.0% -------------------------------------------------------------------- rewrite-expression-head23 [45]100.0% [53] 206(3.6%) 0(0.0%) rewriter ...e/gh-actions/src/core/matcher.rkt:85:2 for-loop [59] 100.0% -------------------------------------------------------------------- ??? [48] 100.0% [54] 194(3.4%) 0(0.0%) generic-sort/key .../racket/private/sort.rkt:156:2 copying-mergesort [61] 100.0% -------------------------------------------------------------------- egraph-add-exprs [49] 100.0% [55] 1286(22.3%) 0(0.0%) ??? ...rbie/gh-actions/src/core/simplify.rkt:103:6 for-loop [62] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 33.9% atab-add-altn [50] 66.1% [56] 1274(22.1%) 0(0.0%) errors ...s/herbie/gh-actions/src/points.rkt:203:0 for-loop [63] 67.0% eval-one-top12 [68] 17.1% temp85_0 [70] 15.9% -------------------------------------------------------------------- real->precision [32] 16.1% location-do [65] 18.3% for-loop [52] 18.3% loop [20] 47.4% [57] 1208(20.9%) 194(3.4%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-mult [67] 31.5% location-do [65] 18.3% approximate9 [64] 18.3% ival-div [73] 15.9% -------------------------------------------------------------------- coerce-contract [51] 100.0% [58] 384(6.6%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [66] 100.0% -------------------------------------------------------------------- rewriter [53] 100.0% [59] 206(3.6%) 0(0.0%) for-loop ...e/gh-actions/src/core/matcher.rkt:87:4 hash-ref! [69] 100.0% -------------------------------------------------------------------- atab-add-altn [50] 100.0% [60] 200(3.5%) 0(0.0%) best-and-tied-at-points ...core/alt-table.rkt:91:0 for-loop [71] 100.0% -------------------------------------------------------------------- generic-sort/key [54] 100.0% [61] 194(3.4%) 0(0.0%) copying-mergesort ...racket/private/sort.rkt:129:8 loop [72] 100.0% -------------------------------------------------------------------- ??? [55] 100.0% [62] 1286(22.3%) 1286(22.3%) for-loop ...gh-actions/src/core/simplify.rkt:121:2 -------------------------------------------------------------------- errors [56] 100.0% [63] 854(14.8%) 224(3.9%) for-loop ...herbie/gh-actions/src/points.rkt:205:2 .../more-scheme.rkt:261:28 [6] 73.8% -------------------------------------------------------------------- ??? [57] 100.0% [64] 442(7.7%) 0(0.0%) approximate9 ...h-actions/src/core/taylor.rkt:11:0 taylor [78] 50.2% for-loop [74] 49.8% -------------------------------------------------------------------- ??? [57] 41.7% location-do [65] 58.3% [65] 442(7.7%) 0(0.0%) location-do ...ie/gh-actions/src/programs.rkt:87:0 location-do [65] 58.3% ??? [57] 41.7% -------------------------------------------------------------------- coerce-contract/f [58] 100.0% [66] 384(6.6%) 384(6.6%) coerce-simple-value ...ract/private/guts.rkt:385:0 -------------------------------------------------------------------- ??? [57] 100.0% [67] 380(6.6%) 380(6.6%) ival-mult .../gh-actions/src/biginterval.rkt:212:0 -------------------------------------------------------------------- errors [56] 100.0% [68] 218(3.8%) 0(0.0%) eval-one-top12 (unknown source) for-loop [87] 100.0% -------------------------------------------------------------------- for-loop [4] 50.0% for-loop [59] 50.0% [69] 206(3.6%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 matcher [75] 100.0% -------------------------------------------------------------------- errors [56] 100.0% [70] 202(3.5%) 0(0.0%) temp85_0 (unknown source) compile15 [76] 100.0% -------------------------------------------------------------------- best-and-tied-at-points [60] 100.0% [71] 200(3.5%) 200(3.5%) for-loop ...gh-actions/src/core/alt-table.rkt:94:4 -------------------------------------------------------------------- copying-mergesort [61] 100.0% [72] 194(3.4%) 194(3.4%) loop ...7.5/collects/racket/private/sort.rkt:96:12 -------------------------------------------------------------------- ??? [57] 100.0% [73] 192(3.3%) 0(0.0%) ival-div ...e/gh-actions/src/biginterval.rkt:250:0 epdiv [77] 100.0% -------------------------------------------------------------------- approximate9 [64] 100.0% [74] 220(3.8%) 0(0.0%) for-loop ...e/gh-actions/src/core/taylor.rkt:29:18 taylor [78] 100.0% -------------------------------------------------------------------- hash-ref! [69] 100.0% [75] 206(3.6%) 0(0.0%) matcher ...e/gh-actions/src/core/matcher.rkt:117:2 ??? [2] 50.0% do-curry [79] 50.0% -------------------------------------------------------------------- temp85_0 [70] 100.0% [76] 202(3.5%) 0(0.0%) compile15 (unknown source) temp91_0 [80] 100.0% -------------------------------------------------------------------- ival-div [73] 100.0% [77] 192(3.3%) 192(3.3%) epdiv ...rbie/gh-actions/src/biginterval.rkt:239:0 -------------------------------------------------------------------- for-loop [74] 49.8% approximate9 [64] 50.2% [78] 442(7.7%) 220(3.8%) taylor ...bie/gh-actions/src/core/taylor.rkt:169:0 debug-print [81] 50.2% -------------------------------------------------------------------- matcher [75] 100.0% [79] 206(3.6%) 206(3.6%) do-curry ...-7.5/collects/racket/function.rkt:71:2 -------------------------------------------------------------------- compile15 [76] 100.0% [80] 202(3.5%) 0(0.0%) temp91_0 (unknown source) temp118_0 [82] 100.0% -------------------------------------------------------------------- taylor [78] 100.0% [81] 222(3.8%) 0(0.0%) debug-print ...rbie/gh-actions/src/debug.rkt:110:0 ??? [83] 100.0% -------------------------------------------------------------------- temp91_0 [80] 100.0% [82] 202(3.5%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [84] 100.0% -------------------------------------------------------------------- debug-print [81] 100.0% [83] 222(3.8%) 222(3.8%) ??? .../contract/private/arrow-val-first.rkt:555:3 -------------------------------------------------------------------- temp118_0 [82] 100.0% [84] 202(3.5%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [85] 100.0% -------------------------------------------------------------------- expand-capturing-lifts [84] 100.0% [85] 202(3.5%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [86] 100.0% -------------------------------------------------------------------- lambda-clause-expander [85] 20.0% for-loop [87] 80.0% [86] 202(3.5%) 0(0.0%) finish-bodys (unknown source) for-loop [87] 100.0% -------------------------------------------------------------------- for-loop [87] 18.0% finish-bodys [86] 30.1% eval-one-top12 [68] 51.9% [87] 420(7.3%) 218(3.8%) for-loop (unknown source) finish-bodys [86] 24.0% for-loop [87] 18.0% add-local-binding!39 [88] 6.0% -------------------------------------------------------------------- for-loop [87] 100.0% [88] 202(3.5%) 202(3.5%) add-local-binding!39 (unknown source) --------------------------------------------------------------------