Profiling results ----------------- Total cpu time observed: 4312ms (out of 4500ms) Number of samples taken: 24 (once every 180ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== [1] 4312(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [6] 100.0% ---------------------------------------------------------------------- ??? [44] 100.0% [2] 754(17.5%) 0(0.0%) approximate9 ...h-actions/src/core/taylor.rkt:11:0 loop [7] 43.5% taylor-sqrt [8] 31.8% taylor [9] 24.7% ---------------------------------------------------------------------- loop [70] 100.0% [3] 176(4.1%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [10] 100.0% ---------------------------------------------------------------------- matcher [58] 100.0% [4] 160(3.7%) 0(0.0%) ??? ...rbie/gh-actions/src/core/matcher.rkt:129:11 for-loop [11] 100.0% ---------------------------------------------------------------------- hash-ref! [52] 100.0% [5] 152(3.5%) 0(0.0%) ??? ...erbie/gh-actions/src/core/taylor.rkt:300:23 for-loop [12] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [6] 4312(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [13] 100.0% ---------------------------------------------------------------------- approximate9 [2] 100.0% [7] 328(7.6%) 0(0.0%) loop ...herbie/gh-actions/src/core/taylor.rkt:86:4 ??? [44] 100.0% ---------------------------------------------------------------------- approximate9 [2] 100.0% [8] 240(5.6%) 0(0.0%) taylor-sqrt ...h-actions/src/core/taylor.rkt:351:0 parse-loop74 [64] 100.0% ---------------------------------------------------------------------- approximate9 [2] 100.0% [9] 186(4.3%) 0(0.0%) taylor ...bie/gh-actions/src/core/taylor.rkt:169:0 taylor-invert [14] 100.0% ---------------------------------------------------------------------- syntax-e [3] 100.0% [10] 176(4.1%) 0(0.0%) syntax-e/no-taint (unknown source) loop [70] 100.0% ---------------------------------------------------------------------- ??? [4] 100.0% [11] 160(3.7%) 0(0.0%) for-loop ...gh-actions/src/core/matcher.rkt:131:15 hash-ref! [52] 100.0% ---------------------------------------------------------------------- ??? [5] 100.0% [12] 152(3.5%) 0(0.0%) for-loop .../gh-actions/src/core/taylor.rkt:303:27 hash-ref! [52] 100.0% ---------------------------------------------------------------------- profile-thunk16 [6] 100.0% [13] 4312(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [15] 100.0% ---------------------------------------------------------------------- taylor [9] 100.0% [14] 186(4.3%) 0(0.0%) taylor-invert ...actions/src/core/taylor.rkt:317:0 parse-loop74 [64] 100.0% ---------------------------------------------------------------------- f61 [56] 3.9% parse-loop74 [64] 6.7% for-loop [48] 12.8% run [13] 76.6% [15] 4312(100.0%) 320(7.4%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [16] 53.9% prepare-points-intervals [17] 17.6% temp85_0 [51] 6.6% ??? [73] 5.6% loop [70] 4.0% oracle-error [19] 3.4% *bit-width* [18] 1.8% errors [43] 1.7% ??? [44] 1.7% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15] 100.0% [16] 3258(75.6%) 0(0.0%) run-improve47 ...gh-actions/src/mainloop.rkt:365:0 for-loop [20] 100.0% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15] 100.0% [17] 758(17.6%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:133:0 loop [21] 100.0% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15] 100.0% [18] 154(3.6%) 154(3.6%) *bit-width* ...erbie/gh-actions/src/float.rkt:34:0 ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15] 100.0% [19] 148(3.4%) 0(0.0%) oracle-error ...ie/gh-actions/src/points.rkt:190:0 for-loop [22] 100.0% ---------------------------------------------------------------------- run-improve47 [16] 100.0% [20] 3258(75.6%) 0(0.0%) for-loop ...rbie/gh-actions/src/mainloop.rkt:384:4 run-iter! [23] 100.0% ---------------------------------------------------------------------- prepare-points-intervals [17] 100.0% [21] 758(17.6%) 162(3.8%) loop ...ies/herbie/gh-actions/src/points.rkt:145:4 loop [24] 78.6% ---------------------------------------------------------------------- oracle-error [19] 100.0% [22] 148(3.4%) 0(0.0%) for-loop ...herbie/gh-actions/src/points.rkt:191:2 loop [70] 100.0% ---------------------------------------------------------------------- for-loop [20] 100.0% [23] 3258(75.6%) 0(0.0%) run-iter! ...bie/gh-actions/src/mainloop.rkt:346:0 finalize-iter! [25] 40.1% gen-series! [26] 28.0% simplify! [27] 26.9% gen-rewrites! [28] 4.9% ---------------------------------------------------------------------- loop [21] 100.0% [24] 596(13.8%) 152(3.5%) loop ...lies/herbie/gh-actions/src/points.rkt:81:2 ??? [31] 25.5% real->precision [30] 24.5% ??? [29] 24.5% ---------------------------------------------------------------------- run-iter! [23] 100.0% [25] 1308(30.3%) 0(0.0%) finalize-iter! ...h-actions/src/mainloop.rkt:278:0 ??? [31] 100.0% ---------------------------------------------------------------------- run-iter! [23] 100.0% [26] 912(21.2%) 0(0.0%) gen-series! ...e/gh-actions/src/mainloop.rkt:160:0 for-loop [32] 100.0% ---------------------------------------------------------------------- run-iter! [23] 100.0% [27] 878(20.4%) 0(0.0%) simplify! ...bie/gh-actions/src/mainloop.rkt:224:0 ??? [33] 100.0% ---------------------------------------------------------------------- run-iter! [23] 100.0% [28] 160(3.7%) 0(0.0%) gen-rewrites! ...gh-actions/src/mainloop.rkt:183:0 for-loop [34] 100.0% ---------------------------------------------------------------------- loop [24] 100.0% [29] 146(3.4%) 146(3.4%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ---------------------------------------------------------------------- loop [24] 100.0% [30] 146(3.4%) 0(0.0%) real->precision ...actions/src/programs.rkt:118:11 ??? [44] 100.0% ---------------------------------------------------------------------- loop [24] 10.4% finalize-iter! [25] 89.6% [31] 1460(33.9%) 152(3.5%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [35] 89.6% ---------------------------------------------------------------------- gen-series! [26] 100.0% [32] 912(21.2%) 0(0.0%) for-loop ...rbie/gh-actions/src/mainloop.rkt:167:7 taylor-alt [36] 100.0% ---------------------------------------------------------------------- simplify! [27] 100.0% [33] 878(20.4%) 0(0.0%) ??? ...erbie/gh-actions/src/core/simplify.rkt:42:0 egraph-run [37] 100.0% ---------------------------------------------------------------------- gen-rewrites! [28] 100.0% [34] 160(3.7%) 0(0.0%) for-loop ...bie/gh-actions/src/mainloop.rkt:191:11 rewrite-expression-head23 [38] 100.0% ---------------------------------------------------------------------- ??? [31] 100.0% [35] 1308(30.3%) 0(0.0%) for-loop ...h-actions/src/core/alt-table.rkt:201:2 atab-add-altn [39] 100.0% ---------------------------------------------------------------------- for-loop [32] 100.0% [36] 912(21.2%) 0(0.0%) taylor-alt ...ie/gh-actions/src/mainloop.rkt:146:0 for-loop [40] 100.0% ---------------------------------------------------------------------- ??? [33] 100.0% [37] 878(20.4%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [41] 100.0% ---------------------------------------------------------------------- for-loop [34] 100.0% [38] 160(3.7%) 0(0.0%) rewrite-expression-head23 ...core/matcher.rkt:83:0 rewriter [42] 100.0% ---------------------------------------------------------------------- for-loop [35] 100.0% [39] 1308(30.3%) 0(0.0%) atab-add-altn ...ions/src/core/alt-table.rkt:204:0 errors [43] 85.9% best-and-tied-at-points [46] 14.1% ---------------------------------------------------------------------- taylor-alt [36] 100.0% [40] 912(21.2%) 0(0.0%) for-loop ...rbie/gh-actions/src/mainloop.rkt:152:6 ??? [44] 100.0% ---------------------------------------------------------------------- egraph-run [37] 100.0% [41] 878(20.4%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [45] 100.0% ---------------------------------------------------------------------- rewrite-expression-head23 [38] 33.3% matcher [58] 66.7% [42] 160(3.7%) 0(0.0%) rewriter ...e/gh-actions/src/core/matcher.rkt:85:2 for-loop [47] 100.0% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15] 11.6% atab-add-altn [39] 88.4% [43] 1272(29.5%) 0(0.0%) errors ...s/herbie/gh-actions/src/points.rkt:203:0 for-loop [48] 86.8% temp85_0 [51] 13.2% ---------------------------------------------------------------------- loop [7] 9.1% real->precision [30] 12.1% .../more-scheme.rkt:261:28 [15] 12.3% location-do [49] 33.3% for-loop [40] 33.3% [44] 1206(28.0%) 294(6.8%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [49] 33.3% approximate9 [2] 26.7% hash-ref! [52] 9.1% f40 [54] 6.6% ---------------------------------------------------------------------- egraph-add-exprs [41] 100.0% [45] 878(20.4%) 0(0.0%) ??? ...rbie/gh-actions/src/core/simplify.rkt:103:6 for-loop [50] 100.0% ---------------------------------------------------------------------- atab-add-altn [39] 100.0% [46] 184(4.3%) 0(0.0%) best-and-tied-at-points ...core/alt-table.rkt:91:0 for-loop [53] 100.0% ---------------------------------------------------------------------- rewriter [42] 100.0% [47] 160(3.7%) 160(3.7%) for-loop ...e/gh-actions/src/core/matcher.rkt:87:4 hash-ref! [52] 66.7% ---------------------------------------------------------------------- errors [43] 100.0% [48] 1104(25.6%) 0(0.0%) for-loop ...herbie/gh-actions/src/points.rkt:205:2 .../more-scheme.rkt:261:28 [15] 100.0% ---------------------------------------------------------------------- location-do [49] 44.7% ??? [44] 55.3% [49] 912(21.2%) 0(0.0%) location-do ...ie/gh-actions/src/programs.rkt:87:0 ??? [44] 55.3% location-do [49] 44.7% ---------------------------------------------------------------------- ??? [45] 100.0% [50] 878(20.4%) 514(11.9%) for-loop ...gh-actions/src/core/simplify.rkt:121:2 ??? [57] 41.5% ---------------------------------------------------------------------- errors [43] 22.8% .../more-scheme.rkt:261:28 [15] 77.2% [51] 736(17.1%) 0(0.0%) temp85_0 (unknown source) compile15 [55] 100.0% ---------------------------------------------------------------------- for-loop [12] 10.4% ??? [59] 10.4% for-loop [11] 16.4% for-loop [47] 16.4% ??? [44] 46.4% [52] 488(11.3%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 f61 [56] 36.1% matcher [58] 32.8% ??? [59] 10.4% ??? [5] 10.4% parse-loop74 [64] 10.4% ---------------------------------------------------------------------- best-and-tied-at-points [46] 100.0% [53] 184(4.3%) 184(4.3%) for-loop ...gh-actions/src/core/alt-table.rkt:94:4 ---------------------------------------------------------------------- ??? [44] 33.3% map [62] 66.7% [54] 158(3.7%) 0(0.0%) f40 (unknown source) map [62] 100.0% ---------------------------------------------------------------------- temp85_0 [51] 100.0% [55] 736(17.1%) 0(0.0%) compile15 (unknown source) temp91_0 [60] 100.0% ---------------------------------------------------------------------- parse-loop74 [64] 31.3% map [62] 32.5% hash-ref! [52] 36.2% [56] 486(11.3%) 0(0.0%) f61 (unknown source) .../more-scheme.rkt:261:28 [15] 68.7% map [62] 31.3% ---------------------------------------------------------------------- for-loop [50] 100.0% [57] 364(8.4%) 0(0.0%) ??? ...gs/egg-herbie-linux/egg-interface.rkt:46:32 list->cblock54 [61] 100.0% ---------------------------------------------------------------------- hash-ref! [52] 100.0% [58] 160(3.7%) 0(0.0%) matcher ...e/gh-actions/src/core/matcher.rkt:117:2 ??? [4] 50.0% rewriter [42] 50.0% ---------------------------------------------------------------------- hash-ref! [52] 100.0% [59] 152(3.5%) 0(0.0%) ??? ...herbie/gh-actions/src/core/taylor.rkt:44:15 hash-ref! [52] 100.0% ---------------------------------------------------------------------- compile15 [55] 100.0% [60] 736(17.1%) 0(0.0%) temp91_0 (unknown source) temp118_0 [63] 100.0% ---------------------------------------------------------------------- ??? [57] 100.0% [61] 364(8.4%) 364(8.4%) list->cblock54 ....5/collects/ffi/unsafe.rkt:32:27 ---------------------------------------------------------------------- f61 [56] 49.0% f40 [54] 51.0% [62] 310(7.2%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 parse-loop74 [64] 49.0% f40 [54] 34.0% f61 [56] 17.0% ---------------------------------------------------------------------- temp91_0 [60] 100.0% [63] 736(17.1%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [65] 100.0% ---------------------------------------------------------------------- map [62] 8.8% parse-loop74 [64] 8.8% hash-ref! [52] 8.8% taylor-invert [14] 32.2% taylor-sqrt [8] 41.5% [64] 578(13.4%) 0(0.0%) parse-loop74 (unknown source) .../more-scheme.rkt:261:28 [15] 82.5% parse-loop74 [64] 8.8% f61 [56] 8.8% ---------------------------------------------------------------------- loop [70] 31.9% temp118_0 [63] 68.1% [65] 1080(25.0%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [66] 68.1% loop [70] 17.2% dispatch-transformer41 [67] 14.6% ---------------------------------------------------------------------- expand-capturing-lifts [65] 100.0% [66] 736(17.1%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [69] 76.1% loop [70] 23.9% ---------------------------------------------------------------------- expand-capturing-lifts [65] 24.2% loop [70] 26.9% for-loop [71] 48.9% [67] 654(15.2%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [68] 100.0% ---------------------------------------------------------------------- dispatch-transformer41 [67] 100.0% [68] 654(15.2%) 320(7.4%) apply-transformer52 (unknown source) loop [70] 26.9% apply-transformer-in-context [72] 24.2% ---------------------------------------------------------------------- lambda-clause-expander [66] 28.4% for-loop [71] 71.6% [69] 560(13.0%) 0(0.0%) finish-bodys (unknown source) for-loop [71] 100.0% ---------------------------------------------------------------------- loop [70] 6.6% syntax-e/no-taint [10] 6.6% apply-transformer52 [68] 6.6% lambda-clause-expander [66] 6.6% expand-capturing-lifts [65] 13.9% for-loop [22] 22.2% .../more-scheme.rkt:261:28 [15] 37.6% [70] 668(15.5%) 186(4.3%) loop (unknown source) expand-capturing-lifts [65] 37.6% ??? [73] 22.2% dispatch-transformer41 [67] 6.6% syntax-e [3] 6.6% loop [70] 6.6% gf [75] 6.6% ---------------------------------------------------------------------- for-loop [71] 32.9% finish-bodys [69] 67.1% [71] 560(13.0%) 0(0.0%) for-loop (unknown source) finish-bodys [69] 48.7% for-loop [71] 32.9% dispatch-transformer41 [67] 12.3% add-local-binding!39 [74] 6.1% ---------------------------------------------------------------------- apply-transformer52 [68] 100.0% [72] 158(3.7%) 0(0.0%) apply-transformer-in-context (unknown source) new-lambda [76] 100.0% ---------------------------------------------------------------------- loop [70] 23.5% .../more-scheme.rkt:261:28 [15] 76.5% [73] 630(14.6%) 630(14.6%) ??? ...bie/gh-actions/src/syntax/syntax.rkt:214:17 ---------------------------------------------------------------------- for-loop [71] 100.0% [74] 240(5.6%) 240(5.6%) add-local-binding!39 (unknown source) ---------------------------------------------------------------------- loop [70] 100.0% [75] 176(4.1%) 176(4.1%) gf (unknown source) ---------------------------------------------------------------------- apply-transformer-in-context [72]100.0% [76] 158(3.7%) 0(0.0%) new-lambda ...ollects/racket/private/kw.rkt:856:11 check-loc [77] 100.0% ---------------------------------------------------------------------- new-lambda [76] 100.0% [77] 158(3.7%) 158(3.7%) check-loc ...cts/racket/private/template.rkt:582:0 ----------------------------------------------------------------------