Profiling results ----------------- Total cpu time observed: 18260ms (out of 18136ms) Number of samples taken: 71 (once every 257ms) (Hiding functions with self<1.0% and local<2.0%: 1 of 108 hidden) ======================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================== [1] 18260(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [8] 100.0% ------------------------------------------------------------------------ ??? [65] 100.0% [2] 3680(20.2%) 0(0.0%) approximate9 ...val-tests/src/core/taylor.rkt:11:0 loop [9] 65.5% taylor [11] 34.5% ------------------------------------------------------------------------ hash-ref! [73] 100.0% [3] 1802(9.9%) 0(0.0%) ??? .../more-ival-tests/src/core/taylor.rkt:300:23 for-loop [10] 100.0% ------------------------------------------------------------------------ hash-ref! [73] 100.0% [4] 1066(5.8%) 0(0.0%) ??? .../more-ival-tests/src/core/taylor.rkt:290:26 for-loop [12] 100.0% ------------------------------------------------------------------------ for-loop [97] 24.9% loop [98] 75.1% [5] 802(4.4%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [13] 100.0% ------------------------------------------------------------------------ hash-ref! [73] 100.0% [6] 496(2.7%) 0(0.0%) f61 (unknown source) composed [14] 100.0% ------------------------------------------------------------------------ matcher [85] 100.0% [7] 200(1.1%) 0(0.0%) ??? ...more-ival-tests/src/core/matcher.rkt:131:11 for-loop [15] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [8] 18260(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [16] 100.0% ------------------------------------------------------------------------ approximate9 [2] 100.0% [9] 2410(13.2%) 0(0.0%) loop ...e/more-ival-tests/src/core/taylor.rkt:86:4 ??? [65] 100.0% ------------------------------------------------------------------------ ??? [3] 100.0% [10] 1802(9.9%) 0(0.0%) for-loop ...-ival-tests/src/core/taylor.rkt:303:27 hash-ref! [73] 100.0% ------------------------------------------------------------------------ taylor [11] 50.0% approximate9 [2] 50.0% [11] 1270(7.0%) 0(0.0%) taylor ...ore-ival-tests/src/core/taylor.rkt:169:0 taylor [11] 50.0% taylor-quotient [17] 50.0% ------------------------------------------------------------------------ ??? [4] 100.0% [12] 1066(5.8%) 0(0.0%) for-loop ...-ival-tests/src/core/taylor.rkt:290:52 ??? [18] 81.1% hash-ref! [73] 18.9% ------------------------------------------------------------------------ expand-id-application-form17 [5]100.0% [13] 802(4.4%) 0(0.0%) syntax-e/no-taint (unknown source) loop [98] 100.0% ------------------------------------------------------------------------ f61 [6] 100.0% [14] 496(2.7%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 free-variables [19] 100.0% ------------------------------------------------------------------------ ??? [7] 100.0% [15] 200(1.1%) 0(0.0%) for-loop ...ival-tests/src/core/matcher.rkt:133:15 hash-ref! [73] 100.0% ------------------------------------------------------------------------ profile-thunk16 [8] 100.0% [16] 18260(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [20] 100.0% ------------------------------------------------------------------------ taylor [11] 100.0% [17] 1270(7.0%) 0(0.0%) taylor-quotient ...tests/src/core/taylor.rkt:333:0 parse-loop74 [21] 100.0% ------------------------------------------------------------------------ for-loop [12] 100.0% [18] 864(4.7%) 0(0.0%) ??? .../more-ival-tests/src/core/taylor.rkt:293:19 hash-ref! [73] 100.0% ------------------------------------------------------------------------ append-map [23] 50.0% composed [14] 50.0% [19] 496(2.7%) 0(0.0%) free-variables ...ival-tests/src/programs.rkt:56:0 append-map [23] 50.0% constant? [22] 50.0% ------------------------------------------------------------------------ for-loop [74] 1.6% run [16] 98.4% [20] 18260(100.0%) 400(2.2%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [24] 51.3% prepare-points-intervals [25] 42.1% oracle-error [27] 3.3% errors [67] 1.7% ??? [105] 0.5% ------------------------------------------------------------------------ map [87] 22.3% hash-ref! [73] 35.1% taylor-quotient [17] 42.6% [21] 2978(16.3%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [26] 100.0% ------------------------------------------------------------------------ free-variables [19] 100.0% [22] 496(2.7%) 0(0.0%) constant? ...val-tests/src/syntax/syntax.rkt:726:0 value? [28] 100.0% ------------------------------------------------------------------------ free-variables [19] 100.0% [23] 496(2.7%) 0(0.0%) append-map ...t-7.5/collects/racket/list.rkt:586:2 free-variables [19] 100.0% ------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [20] 100.0% [24] 9570(52.4%) 0(0.0%) run-improve47 ...ival-tests/src/mainloop.rkt:346:0 for-loop [29] 85.4% simplify! [38] 14.6% ------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [20] 100.0% [25] 7688(42.1%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:120:0 loop [30] 100.0% ------------------------------------------------------------------------ parse-loop74 [21] 100.0% [26] 2978(16.3%) 1270(7.0%) eval-const-expr ...al-tests/src/programs.rkt:120:0 temp85_0 [72] 49.8% loop [98] 7.5% ------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [20] 100.0% [27] 602(3.3%) 0(0.0%) oracle-error ...re-ival-tests/src/points.rkt:177:0 for-loop [31] 100.0% ------------------------------------------------------------------------ constant? [22] 100.0% [28] 496(2.7%) 496(2.7%) value? ...ore-ival-tests/src/syntax/types.rkt:18:0 ------------------------------------------------------------------------ run-improve47 [24] 100.0% [29] 8176(44.8%) 0(0.0%) for-loop ...more-ival-tests/src/mainloop.rkt:365:4 run-iter! [32] 100.0% ------------------------------------------------------------------------ prepare-points-intervals [25] 100.0% [30] 7688(42.1%) 0(0.0%) loop ...erbie/more-ival-tests/src/points.rkt:132:4 loop [33] 86.8% ??? [34] 10.6% do-curry [35] 2.6% ------------------------------------------------------------------------ oracle-error [27] 100.0% [31] 602(3.3%) 0(0.0%) for-loop ...e/more-ival-tests/src/points.rkt:178:2 map [87] 66.4% loop [98] 33.6% ------------------------------------------------------------------------ for-loop [29] 100.0% [32] 8176(44.8%) 0(0.0%) run-iter! ...ore-ival-tests/src/mainloop.rkt:327:0 gen-series! [37] 45.0% simplify! [38] 27.3% finalize-iter! [39] 22.6% gen-rewrites! [42] 5.1% ------------------------------------------------------------------------ loop [30] 100.0% [33] 6676(36.6%) 602(3.3%) loop ...herbie/more-ival-tests/src/points.rkt:79:2 ??? [36] 81.8% real->precision [41] 6.2% ??? [65] 3.0% ------------------------------------------------------------------------ loop [30] 100.0% [34] 812(4.4%) 206(1.1%) ??? ...herbie/more-ival-tests/src/points.rkt:113:6 sample-multi-bounded [40] 74.6% ------------------------------------------------------------------------ loop [30] 100.0% [35] 200(1.1%) 200(1.1%) do-curry ...-7.5/collects/racket/function.rkt:71:2 ------------------------------------------------------------------------ loop [33] 100.0% [36] 5458(29.9%) 2012(11.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-exp [45] 52.1% ival-sub [48] 11.0% ------------------------------------------------------------------------ run-iter! [32] 100.0% [37] 3680(20.2%) 0(0.0%) gen-series! ...e-ival-tests/src/mainloop.rkt:160:0 for-loop [43] 100.0% ------------------------------------------------------------------------ run-improve47 [24] 38.4% run-iter! [32] 61.6% [38] 3628(19.9%) 0(0.0%) simplify! ...ore-ival-tests/src/mainloop.rkt:224:0 ??? [44] 100.0% ------------------------------------------------------------------------ run-iter! [32] 100.0% [39] 1846(10.1%) 0(0.0%) finalize-iter! ...val-tests/src/mainloop.rkt:278:0 ??? [46] 100.0% ------------------------------------------------------------------------ ??? [34] 100.0% [40] 606(3.3%) 0(0.0%) sample-multi-bounded ...-tests/src/points.rkt:14:0 random-ranges [47] 100.0% ------------------------------------------------------------------------ loop [33] 100.0% [41] 416(2.3%) 0(0.0%) real->precision ...al-tests/src/programs.rkt:94:11 ??? [65] 100.0% ------------------------------------------------------------------------ run-iter! [32] 100.0% [42] 416(2.3%) 0(0.0%) gen-rewrites! ...ival-tests/src/mainloop.rkt:183:0 for-loop [49] 51.9% for-loop [50] 48.1% ------------------------------------------------------------------------ gen-series! [37] 100.0% [43] 3680(20.2%) 0(0.0%) for-loop ...more-ival-tests/src/mainloop.rkt:167:7 taylor-alt [51] 100.0% ------------------------------------------------------------------------ simplify! [38] 100.0% [44] 3628(19.9%) 0(0.0%) ??? .../more-ival-tests/src/core/simplify.rkt:42:0 egraph-run [52] 100.0% ------------------------------------------------------------------------ ??? [36] 100.0% [45] 2846(15.6%) 2446(13.4%) ival-exp ...e-ival-tests/src/biginterval.rkt:176:0 bfexp [55] 14.1% ------------------------------------------------------------------------ finalize-iter! [39] 100.0% [46] 1846(10.1%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [53] 100.0% ------------------------------------------------------------------------ sample-multi-bounded [40] 100.0% [47] 606(3.3%) 200(1.1%) random-ranges ...e-ival-tests/src/common.rkt:164:0 cons/c [54] 67.0% ------------------------------------------------------------------------ ??? [36] 100.0% [48] 600(3.3%) 600(3.3%) ival-sub ...e-ival-tests/src/biginterval.rkt:114:0 ------------------------------------------------------------------------ gen-rewrites! [42] 100.0% [49] 216(1.2%) 0(0.0%) for-loop ...more-ival-tests/src/mainloop.rkt:208:4 for-loop [56] 100.0% ------------------------------------------------------------------------ gen-rewrites! [42] 100.0% [50] 200(1.1%) 0(0.0%) for-loop ...ore-ival-tests/src/mainloop.rkt:191:11 rewrite-expression-head24 [57] 100.0% ------------------------------------------------------------------------ for-loop [43] 100.0% [51] 3680(20.2%) 0(0.0%) taylor-alt ...re-ival-tests/src/mainloop.rkt:146:0 for-loop [58] 100.0% ------------------------------------------------------------------------ ??? [44] 100.0% [52] 3628(19.9%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [59] 100.0% ------------------------------------------------------------------------ ??? [46] 100.0% [53] 1846(10.1%) 0(0.0%) for-loop ...ival-tests/src/core/alt-table.rkt:46:2 atab-add-altn [60] 65.8% errors [67] 22.1% loop [61] 12.1% ------------------------------------------------------------------------ random-ranges [47] 100.0% [54] 406(2.2%) 206(1.1%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [63] 49.3% ------------------------------------------------------------------------ ival-exp [45] 100.0% [55] 400(2.2%) 0(0.0%) bfexp ...-lib/math/private/bigfloat/mpfr.rkt:632:4 ??? [62] 50.0% new-mpfr [83] 50.0% ------------------------------------------------------------------------ for-loop [49] 100.0% [56] 216(1.2%) 0(0.0%) for-loop ...more-ival-tests/src/mainloop.rkt:209:6 ??? [65] 100.0% ------------------------------------------------------------------------ for-loop [50] 100.0% [57] 200(1.1%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [64] 100.0% ------------------------------------------------------------------------ taylor-alt [51] 100.0% [58] 3680(20.2%) 0(0.0%) for-loop ...more-ival-tests/src/mainloop.rkt:152:6 ??? [65] 100.0% ------------------------------------------------------------------------ egraph-run [52] 100.0% [59] 3628(19.9%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [66] 100.0% ------------------------------------------------------------------------ for-loop [53] 100.0% [60] 1214(6.6%) 0(0.0%) atab-add-altn ...ests/src/core/alt-table.rkt:194:0 errors [67] 100.0% ------------------------------------------------------------------------ for-loop [53] 100.0% [61] 224(1.2%) 224(1.2%) loop ...re-ival-tests/src/core/alt-table.rkt:168:2 ------------------------------------------------------------------------ bfexp [55] 100.0% [62] 200(1.1%) 200(1.1%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ------------------------------------------------------------------------ cons/c [54] 100.0% [63] 200(1.1%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [68] 100.0% ------------------------------------------------------------------------ rewrite-expression-head24 [57] 20.0% matcher [85] 80.0% [64] 200(1.1%) 200(1.1%) rewriter ...e-ival-tests/src/core/matcher.rkt:87:2 for-loop [69] 80.0% ------------------------------------------------------------------------ loop [33] 4.4% for-loop [56] 4.8% real->precision [41] 9.2% loop [9] 17.8% location-do [70] 31.9% for-loop [58] 31.9% [65] 4512(24.7%) 200(1.1%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [70] 31.9% approximate9 [2] 31.9% hash-ref! [73] 17.8% bf [76] 4.8% ??? [75] 4.8% ival-div [77] 4.4% ------------------------------------------------------------------------ egraph-add-exprs [59] 100.0% [66] 3628(19.9%) 0(0.0%) ??? ...more-ival-tests/src/core/simplify.rkt:102:6 for-loop [71] 100.0% ------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [20] 19.8% for-loop [53] 20.2% atab-add-altn [60] 60.0% [67] 2022(11.1%) 0(0.0%) errors ...bie/more-ival-tests/src/points.rkt:190:0 temp85_0 [72] 60.4% for-loop [74] 39.6% ------------------------------------------------------------------------ coerce-contract [63] 100.0% [68] 200(1.1%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [78] 100.0% ------------------------------------------------------------------------ rewriter [64] 100.0% [69] 200(1.1%) 0(0.0%) for-loop ...e-ival-tests/src/core/matcher.rkt:89:4 hash-ref! [73] 100.0% ------------------------------------------------------------------------ ??? [65] 39.5% location-do [70] 60.5% [70] 3680(20.2%) 0(0.0%) location-do ...re-ival-tests/src/programs.rkt:63:0 location-do [70] 60.5% ??? [65] 39.5% ------------------------------------------------------------------------ ??? [66] 100.0% [71] 3628(19.9%) 3628(19.9%) for-loop ...ival-tests/src/core/simplify.rkt:121:2 ------------------------------------------------------------------------ errors [67] 45.2% eval-const-expr [26] 54.8% [72] 2706(14.8%) 0(0.0%) temp85_0 (unknown source) compile15 [79] 100.0% ------------------------------------------------------------------------ for-loop [12] 1.9% for-loop [15] 3.8% for-loop [69] 3.8% ??? [18] 7.6% ??? [81] 10.5% ??? [80] 23.5% ??? [65] 23.5% for-loop [10] 24.4% [73] 2610(14.3%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [3] 24.4% ??? [80] 23.5% parse-loop74 [21] 10.5% ??? [81] 10.5% ??? [4] 9.5% f40 [82] 9.1% matcher [85] 7.7% f61 [6] 3.8% ------------------------------------------------------------------------ errors [67] 100.0% [74] 800(4.4%) 0(0.0%) for-loop ...e/more-ival-tests/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [20] 74.5% ??? [84] 25.5% ------------------------------------------------------------------------ ??? [65] 100.0% [75] 216(1.2%) 216(1.2%) ??? ...cts/racket/contract/private/list.rkt:209:10 ------------------------------------------------------------------------ ??? [65] 100.0% [76] 216(1.2%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [83] 100.0% ------------------------------------------------------------------------ ??? [65] 100.0% [77] 200(1.1%) 200(1.1%) ival-div ...e-ival-tests/src/biginterval.rkt:146:0 ------------------------------------------------------------------------ coerce-contract/f [68] 100.0% [78] 200(1.1%) 200(1.1%) coerce-simple-value ...ract/private/guts.rkt:385:0 ------------------------------------------------------------------------ temp85_0 [72] 100.0% [79] 2706(14.8%) 0(0.0%) compile15 (unknown source) temp91_0 [86] 90.2% loop [98] 9.8% ------------------------------------------------------------------------ hash-ref! [73] 100.0% [80] 2410(13.2%) 0(0.0%) ??? ...e/more-ival-tests/src/core/taylor.rkt:44:15 hash-ref! [73] 100.0% ------------------------------------------------------------------------ hash-ref! [73] 100.0% [81] 1122(6.1%) 0(0.0%) ??? .../more-ival-tests/src/core/taylor.rkt:343:33 hash-ref! [73] 100.0% ------------------------------------------------------------------------ hash-ref! [73] 22.3% map [87] 77.7% [82] 870(4.8%) 0(0.0%) f40 (unknown source) map [87] 100.0% ------------------------------------------------------------------------ bfexp [55] 48.1% bf [76] 51.9% [83] 416(2.3%) 416(2.3%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ------------------------------------------------------------------------ for-loop [74] 100.0% [84] 204(1.1%) 204(1.1%) ??? ...7.5/collects/racket/private/for.rkt:1236:14 ------------------------------------------------------------------------ hash-ref! [73] 100.0% [85] 200(1.1%) 0(0.0%) matcher ...e-ival-tests/src/core/matcher.rkt:119:2 ??? [7] 50.0% rewriter [64] 50.0% ------------------------------------------------------------------------ compile15 [79] 100.0% [86] 2442(13.4%) 0(0.0%) temp91_0 (unknown source) temp118_0 [88] 83.5% compile-top9 [89] 16.5% ------------------------------------------------------------------------ for-loop [31] 31.5% f40 [82] 68.5% [87] 1270(7.0%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 f40 [82] 53.2% ??? [102] 31.5% parse-loop74 [21] 12.0% simplify* [90] 3.2% ------------------------------------------------------------------------ temp91_0 [86] 100.0% [88] 2040(11.2%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [91] 100.0% ------------------------------------------------------------------------ temp91_0 [86] 100.0% [89] 402(2.2%) 0(0.0%) compile-top9 (unknown source) compile-forms33 [92] 100.0% ------------------------------------------------------------------------ map [87] 100.0% [90] 206(1.1%) 206(1.1%) simplify* ...e-ival-tests/src/core/reduce.rkt:29:0 ------------------------------------------------------------------------ loop [98] 19.3% temp118_0 [88] 80.7% [91] 2528(13.8%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [93] 80.7% loop [98] 10.4% dispatch-transformer41 [94] 8.9% ------------------------------------------------------------------------ compile-top9 [89] 100.0% [92] 402(2.2%) 0(0.0%) compile-forms33 (unknown source) for-loop [97] 100.0% ------------------------------------------------------------------------ expand-capturing-lifts [91] 100.0% [93] 2040(11.2%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [95] 100.0% ------------------------------------------------------------------------ expand-capturing-lifts [91] 100.0% [94] 224(1.2%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [96] 100.0% ------------------------------------------------------------------------ lambda-clause-expander [93] 25.8% for-loop [97] 74.2% [95] 2040(11.2%) 0(0.0%) finish-bodys (unknown source) for-loop [97] 100.0% ------------------------------------------------------------------------ dispatch-transformer41 [94] 100.0% [96] 224(1.2%) 224(1.2%) apply-transformer52 (unknown source) ------------------------------------------------------------------------ compile-forms33 [92] 16.5% for-loop [97] 18.4% finish-bodys [95] 65.2% [97] 2442(13.4%) 1030(5.6%) for-loop (unknown source) finish-bodys [95] 52.7% for-loop [97] 18.4% compile-module-linklet57 [100] 8.3% dispatch-variable [99] 3.1% expand-id-application-form17 [5] 2.7% loop [98] 1.5% ------------------------------------------------------------------------ expand-capturing-lifts [91] 8.8% compile15 [79] 8.8% for-loop [31] 13.5% eval-const-expr [26] 15.0% for-loop [97] 20.2% syntax-e/no-taint [13] 33.6% [98] 1492(8.2%) 264(1.4%) loop (unknown source) gf [101] 33.6% expand-capturing-lifts [91] 23.9% expand-id-application-form17 [5] 20.2% ??? [102] 13.5% ------------------------------------------------------------------------ for-loop [97] 100.0% [99] 408(2.2%) 0(0.0%) dispatch-variable (unknown source) substitute-variable6 [103] 100.0% ------------------------------------------------------------------------ for-loop [97] 100.0% [100] 202(1.1%) 202(1.1%) compile-module-linklet57 (unknown source) ------------------------------------------------------------------------ loop [98] 100.0% [101] 802(4.4%) 0(0.0%) gf (unknown source) propagation-apply [104] 75.1% propagation-merge [106] 24.9% ------------------------------------------------------------------------ loop [98] 33.6% map [87] 66.4% [102] 602(3.3%) 0(0.0%) ??? ...erbie/more-ival-tests/src/points.rkt:179:26 ??? [105] 66.8% ??? [107] 33.2% ------------------------------------------------------------------------ dispatch-variable [99] 100.0% [103] 408(2.2%) 408(2.2%) substitute-variable6 (unknown source) ------------------------------------------------------------------------ gf [101] 100.0% [104] 602(3.3%) 602(3.3%) propagation-apply (unknown source) ------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [20] 32.8% ??? [102] 67.2% [105] 598(3.3%) 398(2.2%) ??? ...ore-ival-tests/src/syntax/syntax.rkt:214:17 ??? [107] 33.4% ------------------------------------------------------------------------ gf [101] 100.0% [106] 200(1.1%) 200(1.1%) propagation-merge (unknown source) ------------------------------------------------------------------------ ??? [105] 50.0% ??? [102] 50.0% [107] 400(2.2%) 400(2.2%) ??? ...ects/racket/contract/private/guts.rkt:770:8 ------------------------------------------------------------------------