Profiling results ----------------- Total cpu time observed: 14230ms (out of 14368ms) Number of samples taken: 67 (once every 212ms) ======================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================== [1] 14230(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [4] 100.0% ------------------------------------------------------------------------ for-loop [73] 100.0% [2] 600(4.2%) 198(1.4%) expand-implicit (unknown source) resolve+shift28 [5] 67.0% ------------------------------------------------------------------------ matcher [59] 100.0% [3] 210(1.5%) 0(0.0%) ??? ...ction-both-ends/src/core/matcher.rkt:127:11 for-loop [6] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [4] 14230(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [7] 100.0% ------------------------------------------------------------------------ expand-implicit [2] 100.0% [5] 402(2.8%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [8] 100.0% ------------------------------------------------------------------------ ??? [3] 100.0% [6] 210(1.5%) 0(0.0%) for-loop ...-both-ends/src/core/matcher.rkt:129:15 matcher [59] 100.0% ------------------------------------------------------------------------ profile-thunk16 [4] 100.0% [7] 14230(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [9] 100.0% ------------------------------------------------------------------------ resolve+shift28 [5] 100.0% [8] 402(2.8%) 200(1.4%) fallback-loop (unknown source) for-loop [73] 50.2% ------------------------------------------------------------------------ for-loop [52] 6.6% run [7] 93.4% [9] 14230(100.0%) 856(6.0%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [13] 58.4% run-improve47 [10] 27.2% errors [46] 3.6% ??? [78] 3.6% oracle-error [11] 2.8% eval-errors [12] 1.4% ------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [9] 100.0% [10] 4496(31.6%) 0(0.0%) run-improve47 ...-both-ends/src/mainloop.rkt:346:0 for-loop [14] 83.5% prepare-points-intervals [13] 9.5% simplify! [22] 6.9% ------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [9] 100.0% [11] 400(2.8%) 0(0.0%) oracle-error ...ion-both-ends/src/points.rkt:190:0 for-loop [15] 100.0% ------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [9] 100.0% [12] 200(1.4%) 0(0.0%) eval-errors ...tion-both-ends/src/points.rkt:181:0 for-loop [16] 100.0% ------------------------------------------------------------------------ run-improve47 [10] 4.9% .../more-scheme.rkt:261:28 [9] 95.1% [13] 8738(61.4%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:133:0 loop [17] 100.0% ------------------------------------------------------------------------ run-improve47 [10] 100.0% [14] 3756(26.4%) 0(0.0%) for-loop ...ction-both-ends/src/mainloop.rkt:365:4 run-iter! [18] 100.0% ------------------------------------------------------------------------ oracle-error [11] 100.0% [15] 400(2.8%) 0(0.0%) for-loop ...tection-both-ends/src/points.rkt:191:2 loop [77] 50.0% map [19] 50.0% ------------------------------------------------------------------------ eval-errors [12] 100.0% [16] 200(1.4%) 0(0.0%) for-loop ...tection-both-ends/src/points.rkt:183:2 ??? [78] 100.0% ------------------------------------------------------------------------ prepare-points-intervals [13] 100.0% [17] 8738(61.4%) 386(2.7%) loop ...w-detection-both-ends/src/points.rkt:145:4 loop [20] 95.6% ------------------------------------------------------------------------ for-loop [14] 100.0% [18] 3756(26.4%) 0(0.0%) run-iter! ...tion-both-ends/src/mainloop.rkt:327:0 finalize-iter! [21] 70.9% simplify! [22] 18.2% gen-rewrites! [23] 5.6% localize! [25] 5.3% ------------------------------------------------------------------------ parse-loop15 [45] 50.0% for-loop [15] 50.0% [19] 400(2.8%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 ??? [24] 50.0% hash-ref! [40] 50.0% ------------------------------------------------------------------------ loop [17] 100.0% [20] 8352(58.7%) 646(4.5%) loop ...ow-detection-both-ends/src/points.rkt:81:2 ??? [26] 65.3% ??? [28] 27.0% ------------------------------------------------------------------------ run-iter! [18] 100.0% [21] 2664(18.7%) 0(0.0%) finalize-iter! ...both-ends/src/mainloop.rkt:278:0 ??? [27] 100.0% ------------------------------------------------------------------------ run-improve47 [10] 31.4% run-iter! [18] 68.6% [22] 994(7.0%) 0(0.0%) simplify! ...tion-both-ends/src/mainloop.rkt:224:0 ??? [29] 100.0% ------------------------------------------------------------------------ run-iter! [18] 100.0% [23] 210(1.5%) 0(0.0%) gen-rewrites! ...-both-ends/src/mainloop.rkt:183:0 for-loop [30] 100.0% ------------------------------------------------------------------------ map [19] 100.0% [24] 200(1.4%) 200(1.4%) ??? ...w-detection-both-ends/src/points.rkt:192:26 ------------------------------------------------------------------------ run-iter! [18] 100.0% [25] 200(1.4%) 0(0.0%) localize! ...tion-both-ends/src/mainloop.rkt:127:0 localize-error [31] 100.0% ------------------------------------------------------------------------ loop [20] 100.0% [26] 5454(38.3%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-mult [33] 44.3% ival-pow [35] 37.1% ival-div [36] 18.6% ------------------------------------------------------------------------ finalize-iter! [21] 100.0% [27] 2664(18.7%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [32] 92.2% atab-add-altns [39] 7.8% ------------------------------------------------------------------------ loop [20] 100.0% [28] 2252(15.8%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-add [34] 100.0% ------------------------------------------------------------------------ simplify! [22] 100.0% [29] 994(7.0%) 0(0.0%) ??? ...ection-both-ends/src/core/simplify.rkt:42:0 egraph-run [37] 100.0% ------------------------------------------------------------------------ gen-rewrites! [23] 100.0% [30] 210(1.5%) 0(0.0%) for-loop ...tion-both-ends/src/mainloop.rkt:191:11 rewrite-expression-head24 [38] 100.0% ------------------------------------------------------------------------ localize! [25] 100.0% [31] 200(1.4%) 0(0.0%) localize-error ...-ends/src/core/localize.rkt:58:0 hash-ref! [40] 100.0% ------------------------------------------------------------------------ ??? [27] 100.0% [32] 2456(17.3%) 0(0.0%) for-loop ...-both-ends/src/core/alt-table.rkt:46:2 atab-add-altn [42] 66.5% errors [46] 33.5% ------------------------------------------------------------------------ ??? [26] 100.0% [33] 2416(17.0%) 644(4.5%) ival-mult ...n-both-ends/src/biginterval.rkt:225:0 e-compute7 [41] 73.3% ------------------------------------------------------------------------ ??? [28] 100.0% [34] 2252(15.8%) 408(2.9%) ival-add ...on-both-ends/src/biginterval.rkt:202:0 e-compute7 [41] 81.9% ------------------------------------------------------------------------ ??? [26] 100.0% [35] 2022(14.2%) 422(3.0%) ival-pow ...on-both-ends/src/biginterval.rkt:331:0 e-compute7 [41] 79.1% ------------------------------------------------------------------------ ??? [26] 100.0% [36] 1016(7.1%) 0(0.0%) ival-div ...on-both-ends/src/biginterval.rkt:251:0 e-compute7 [41] 100.0% ------------------------------------------------------------------------ ??? [29] 100.0% [37] 994(7.0%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [43] 100.0% ------------------------------------------------------------------------ for-loop [30] 100.0% [38] 210(1.5%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [44] 100.0% ------------------------------------------------------------------------ ??? [27] 100.0% [39] 208(1.5%) 0(0.0%) atab-add-altns ...ends/src/core/alt-table.rkt:40:0 atab-add-altn [42] 100.0% ------------------------------------------------------------------------ localize-error [31] 16.7% map [19] 83.3% [40] 200(1.4%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop15 [45] 100.0% ------------------------------------------------------------------------ ival-div [36] 16.3% ival-pow [35] 25.7% ival-mult [33] 28.4% ival-add [34] 29.6% [41] 6232(43.8%) 1610(11.3%) e-compute7 ...-both-ends/src/biginterval.rkt:149:0 bfadd [47] 51.5% ormap [48] 16.4% strong-immovable-endpoint-0? [54] 6.3% ------------------------------------------------------------------------ atab-add-altns [39] 11.3% for-loop [32] 88.7% [42] 1842(12.9%) 0(0.0%) atab-add-altn ...ends/src/core/alt-table.rkt:194:0 errors [46] 100.0% ------------------------------------------------------------------------ egraph-run [37] 100.0% [43] 994(7.0%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [49] 100.0% ------------------------------------------------------------------------ matcher [59] 50.0% rewrite-expression-head24 [38] 50.0% [44] 210(1.5%) 210(1.5%) rewriter ...on-both-ends/src/core/matcher.rkt:87:2 for-loop [50] 50.0% ------------------------------------------------------------------------ hash-ref! [40] 100.0% [45] 200(1.4%) 0(0.0%) parse-loop15 (unknown source) map [19] 83.3% for-loop [51] 16.7% ------------------------------------------------------------------------ for-loop [32] 23.6% .../more-scheme.rkt:261:28 [9] 23.6% atab-add-altn [42] 52.8% [46] 3488(24.5%) 0(0.0%) errors ...detection-both-ends/src/points.rkt:203:0 for-loop [52] 59.5% temp85_0 [55] 34.7% eval [60] 5.8% ------------------------------------------------------------------------ e-compute7 [41] 100.0% [47] 3208(22.5%) 582(4.1%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [53] 62.3% ??? [57] 19.6% ------------------------------------------------------------------------ e-compute7 [41] 100.0% [48] 1020(7.2%) 0(0.0%) ormap ....5/collects/racket/private/map.rkt:141:13 strong-immovable-endpoint-0? [54] 80.4% strong-immovable-endpoint? [62] 19.6% ------------------------------------------------------------------------ egraph-add-exprs [43] 100.0% [49] 994(7.0%) 0(0.0%) ??? ...ction-both-ends/src/core/simplify.rkt:102:6 for-loop [56] 65.8% egg-run-rules [58] 34.2% ------------------------------------------------------------------------ rewriter [44] 100.0% [50] 210(1.5%) 0(0.0%) for-loop ...on-both-ends/src/core/matcher.rkt:89:4 matcher [59] 100.0% ------------------------------------------------------------------------ parse-loop15 [45] 100.0% [51] 200(1.4%) 0(0.0%) for-loop ...-both-ends/src/core/localize.rkt:45:21 for-loop [61] 100.0% ------------------------------------------------------------------------ errors [46] 100.0% [52] 2076(14.6%) 208(1.5%) for-loop ...tection-both-ends/src/points.rkt:205:2 .../more-scheme.rkt:261:28 [9] 90.0% ------------------------------------------------------------------------ bfadd [47] 100.0% [53] 1998(14.0%) 1998(14.0%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ------------------------------------------------------------------------ e-compute7 [41] 32.5% ormap [48] 67.5% [54] 1214(8.5%) 1214(8.5%) strong-immovable-endpoint-0? ...interval.rkt:116:0 ------------------------------------------------------------------------ errors [46] 100.0% [55] 1210(8.5%) 0(0.0%) temp85_0 (unknown source) compile15 [63] 100.0% ------------------------------------------------------------------------ ??? [49] 100.0% [56] 654(4.6%) 654(4.6%) for-loop ...-both-ends/src/core/simplify.rkt:121:2 ------------------------------------------------------------------------ bfadd [47] 100.0% [57] 628(4.4%) 628(4.4%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ------------------------------------------------------------------------ ??? [49] 100.0% [58] 340(2.4%) 0(0.0%) egg-run-rules ...-ends/src/core/simplify.rkt:108:0 debug-print [64] 100.0% ------------------------------------------------------------------------ for-loop [6] 50.0% for-loop [50] 50.0% [59] 210(1.5%) 0(0.0%) matcher ...on-both-ends/src/core/matcher.rkt:115:2 ??? [3] 50.0% rewriter [44] 50.0% ------------------------------------------------------------------------ errors [46] 100.0% [60] 202(1.4%) 0(0.0%) eval (unknown source) namespace-syntax-introduce3 [65] 100.0% ------------------------------------------------------------------------ for-loop [51] 100.0% [61] 200(1.4%) 200(1.4%) for-loop ...-both-ends/src/core/localize.rkt:46:23 ------------------------------------------------------------------------ ormap [48] 100.0% [62] 200(1.4%) 200(1.4%) strong-immovable-endpoint? ...iginterval.rkt:106:0 ------------------------------------------------------------------------ temp85_0 [55] 100.0% [63] 1210(8.5%) 0(0.0%) compile15 (unknown source) temp91_0 [66] 100.0% ------------------------------------------------------------------------ egg-run-rules [58] 100.0% [64] 340(2.4%) 340(2.4%) debug-print ...ction-both-ends/src/debug.rkt:110:0 ------------------------------------------------------------------------ eval [60] 100.0% [65] 202(1.4%) 202(1.4%) namespace-syntax-introduce3 (unknown source) ------------------------------------------------------------------------ compile15 [63] 100.0% [66] 1210(8.5%) 0(0.0%) temp91_0 (unknown source) temp118_0 [67] 83.5% compile-top9 [68] 16.5% ------------------------------------------------------------------------ temp91_0 [66] 100.0% [67] 1010(7.1%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [69] 100.0% ------------------------------------------------------------------------ temp91_0 [66] 100.0% [68] 200(1.4%) 0(0.0%) compile-top9 (unknown source) compile-forms33 [70] 100.0% ------------------------------------------------------------------------ temp118_0 [67] 100.0% [69] 1010(7.1%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [71] 100.0% ------------------------------------------------------------------------ compile-top9 [68] 100.0% [70] 200(1.4%) 0(0.0%) compile-forms33 (unknown source) for-loop [73] 100.0% ------------------------------------------------------------------------ expand-capturing-lifts [69] 100.0% [71] 1010(7.1%) 208(1.5%) lambda-clause-expander (unknown source) finish-bodys [72] 79.4% ------------------------------------------------------------------------ lambda-clause-expander [71] 16.3% for-loop [73] 83.7% [72] 802(5.6%) 0(0.0%) finish-bodys (unknown source) for-loop [73] 100.0% ------------------------------------------------------------------------ fallback-loop [8] 2.9% for-loop [73] 17.9% compile-forms33 [70] 20.0% finish-bodys [72] 59.3% [73] 1002(7.0%) 202(1.4%) for-loop (unknown source) finish-bodys [72] 51.8% compile-module-linklet57 [75] 20.0% for-loop [73] 17.9% expand-implicit [2] 6.8% syntax-e [74] 0.7% ------------------------------------------------------------------------ for-loop [73] 100.0% [74] 202(1.4%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [76] 100.0% ------------------------------------------------------------------------ for-loop [73] 100.0% [75] 200(1.4%) 200(1.4%) compile-module-linklet57 (unknown source) ------------------------------------------------------------------------ syntax-e [74] 100.0% [76] 202(1.4%) 0(0.0%) syntax-e/no-taint (unknown source) loop [77] 100.0% ------------------------------------------------------------------------ for-loop [15] 49.8% syntax-e/no-taint [76] 50.2% [77] 402(2.8%) 0(0.0%) loop (unknown source) gf [79] 50.2% ??? [78] 49.8% ------------------------------------------------------------------------ for-loop [16] 14.2% loop [77] 14.2% .../more-scheme.rkt:261:28 [9] 71.7% [78] 1412(9.9%) 1210(8.5%) ??? ...tion-both-ends/src/syntax/syntax.rkt:214:17 return/no-unsupplied [81] 14.3% ------------------------------------------------------------------------ loop [77] 100.0% [79] 202(1.4%) 0(0.0%) gf (unknown source) propagation-apply [80] 100.0% ------------------------------------------------------------------------ gf [79] 100.0% [80] 202(1.4%) 202(1.4%) propagation-apply (unknown source) ------------------------------------------------------------------------ ??? [78] 100.0% [81] 202(1.4%) 0(0.0%) return/no-unsupplied ...ct/private/arr-i.rkt:566:0 filter [82] 100.0% ------------------------------------------------------------------------ return/no-unsupplied [81] 100.0% [82] 202(1.4%) 202(1.4%) filter ...5/collects/racket/private/list.rkt:256:2 ------------------------------------------------------------------------