Profiling results ----------------- Total cpu time observed: 9616ms (out of 9748ms) Number of samples taken: 55 (once every 175ms) ===================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ===================================================================== [1] 9616(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [6] 100.0% --------------------------------------------------------------------- hash-ref! [66] 100.0% [2] 668(6.9%) 0(0.0%) parse-loop75 (unknown source) eval-const-expr [7] 100.0% --------------------------------------------------------------------- hash-ref! [66] 100.0% [3] 494(5.1%) 0(0.0%) ??? ...rbie/egg-cleanup/src/core/taylor.rkt:301:23 for-loop [8] 100.0% --------------------------------------------------------------------- for-loop [46] 100.0% [4] 342(3.6%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [9] 100.0% --------------------------------------------------------------------- hash-ref! [66] 100.0% [5] 152(1.6%) 0(0.0%) ??? ...s/herbie/egg-cleanup/src/programs.rkt:177:5 hash-ref! [66] 50.0% loop [44] 50.0% --------------------------------------------------------------------- ??? [1] 100.0% [6] 9616(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [10] 100.0% --------------------------------------------------------------------- parse-loop75 [2] 100.0% [7] 668(6.9%) 0(0.0%) eval-const-expr ...-cleanup/src/programs.rkt:118:0 temp85_0 [11] 77.2% compile [12] 22.8% --------------------------------------------------------------------- ??? [3] 100.0% [8] 494(5.1%) 0(0.0%) for-loop ...egg-cleanup/src/core/taylor.rkt:304:27 hash-ref! [66] 100.0% --------------------------------------------------------------------- syntax-e [4] 100.0% [9] 342(3.6%) 0(0.0%) syntax-e/no-taint (unknown source) loop [44] 100.0% --------------------------------------------------------------------- profile-thunk16 [6] 100.0% [10] 9616(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% --------------------------------------------------------------------- eval-const-expr [7] 100.0% [11] 516(5.4%) 0(0.0%) temp85_0 (unknown source) compile15 [14] 100.0% --------------------------------------------------------------------- eval-const-expr [7] 100.0% [12] 152(1.6%) 0(0.0%) compile ...rbie/egg-cleanup/src/programs.rkt:169:0 hash-ref! [66] 100.0% --------------------------------------------------------------------- run [10] 100.0% [13] 9616(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [19] 77.2% run-improve47 [15] 18.6% oracle-error [17] 2.2% baseline-error [18] 2.0% --------------------------------------------------------------------- temp85_0 [11] 100.0% [14] 516(5.4%) 0(0.0%) compile15 (unknown source) temp91_0 [16] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13]100.0% [15] 1788(18.6%) 0(0.0%) run-improve47 ...gg-cleanup/src/mainloop.rkt:346:0 for-loop [20] 81.3% prepare-points-intervals [19] 9.6% simplify! [33] 9.1% --------------------------------------------------------------------- compile15 [14] 100.0% [16] 516(5.4%) 0(0.0%) temp91_0 (unknown source) temp118_0 [21] 66.3% compile-top9 [24] 33.7% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13]100.0% [17] 212(2.2%) 0(0.0%) oracle-error ...e/egg-cleanup/src/points.rkt:188:0 for-loop [22] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13]100.0% [18] 190(2.0%) 0(0.0%) baseline-error ...egg-cleanup/src/points.rkt:192:0 argmin [23] 100.0% --------------------------------------------------------------------- run-improve47 [15] 2.3% .../more-scheme.rkt:261:28 [13] 97.7% [19] 7598(79.0%) 0(0.0%) prepare-points-intervals ...p/src/points.rkt:110:0 loop [25] 100.0% --------------------------------------------------------------------- run-improve47 [15] 100.0% [20] 1454(15.1%) 0(0.0%) for-loop ...bie/egg-cleanup/src/mainloop.rkt:365:4 run-iter! [26] 100.0% --------------------------------------------------------------------- temp91_0 [16] 100.0% [21] 342(3.6%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [27] 100.0% --------------------------------------------------------------------- oracle-error [17] 100.0% [22] 212(2.2%) 0(0.0%) for-loop ...erbie/egg-cleanup/src/points.rkt:189:2 loop [44] 100.0% --------------------------------------------------------------------- baseline-error [18] 100.0% [23] 190(2.0%) 0(0.0%) argmin ...acket-7.5/collects/racket/list.rkt:765:0 ??? [28] 100.0% --------------------------------------------------------------------- temp91_0 [16] 100.0% [24] 174(1.8%) 0(0.0%) compile-top9 (unknown source) compile-forms33 [29] 100.0% --------------------------------------------------------------------- prepare-points-intervals [19] 100.0% [25] 7598(79.0%) 714(7.4%) loop ...es/herbie/egg-cleanup/src/points.rkt:123:4 ??? [30] 51.2% loop [31] 39.4% --------------------------------------------------------------------- for-loop [20] 100.0% [26] 1454(15.1%) 0(0.0%) run-iter! ...ie/egg-cleanup/src/mainloop.rkt:327:0 gen-series! [32] 45.9% simplify! [33] 29.7% finalize-iter! [34] 24.3% --------------------------------------------------------------------- temp118_0 [21] 100.0% [27] 342(3.6%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [35] 100.0% --------------------------------------------------------------------- argmin [23] 100.0% [28] 190(2.0%) 0(0.0%) ??? ...es/herbie/egg-cleanup/src/points.rkt:193:27 eval-errors [36] 100.0% --------------------------------------------------------------------- compile-top9 [24] 100.0% [29] 174(1.8%) 0(0.0%) compile-forms33 (unknown source) for-loop [46] 100.0% --------------------------------------------------------------------- loop [25] 100.0% [30] 3890(40.5%) 388(4.0%) ??? ...ies/herbie/egg-cleanup/src/points.rkt:106:2 ??? [58] 81.7% ??? [43] 8.3% --------------------------------------------------------------------- loop [25] 100.0% [31] 2994(31.1%) 328(3.4%) loop ...ies/herbie/egg-cleanup/src/points.rkt:81:2 ??? [37] 84.0% ??? [70] 5.1% --------------------------------------------------------------------- run-iter! [26] 100.0% [32] 668(6.9%) 0(0.0%) gen-series! .../egg-cleanup/src/mainloop.rkt:160:0 for-loop [38] 100.0% --------------------------------------------------------------------- run-improve47 [15] 27.3% run-iter! [26] 72.7% [33] 594(6.2%) 0(0.0%) simplify! ...ie/egg-cleanup/src/mainloop.rkt:224:0 ??? [39] 100.0% --------------------------------------------------------------------- run-iter! [26] 100.0% [34] 354(3.7%) 0(0.0%) finalize-iter! ...g-cleanup/src/mainloop.rkt:278:0 ??? [40] 100.0% --------------------------------------------------------------------- expand-capturing-lifts [27] 100.0% [35] 342(3.6%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [41] 100.0% --------------------------------------------------------------------- ??? [28] 100.0% [36] 190(2.0%) 0(0.0%) eval-errors ...ie/egg-cleanup/src/points.rkt:179:0 for-loop [42] 100.0% --------------------------------------------------------------------- loop [44] 7.8% loop [31] 92.2% [37] 2726(28.3%) 0(0.0%) ??? ...s/herbie/egg-cleanup/src/programs.rkt:115:2 ??? [43] 62.5% ??? [58] 37.5% --------------------------------------------------------------------- gen-series! [32] 100.0% [38] 668(6.9%) 0(0.0%) for-loop ...bie/egg-cleanup/src/mainloop.rkt:167:7 taylor-alt [45] 100.0% --------------------------------------------------------------------- simplify! [33] 100.0% [39] 594(6.2%) 0(0.0%) ??? ...rbie/egg-cleanup/src/core/simplify.rkt:35:0 egraph-run [47] 63.6% loop [44] 36.4% --------------------------------------------------------------------- finalize-iter! [34] 100.0% [40] 354(3.7%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [48] 100.0% --------------------------------------------------------------------- lambda-clause-expander [35] 1.3% for-loop [46] 98.7% [41] 342(3.6%) 0(0.0%) finish-bodys (unknown source) for-loop [46] 100.0% --------------------------------------------------------------------- eval-errors [36] 100.0% [42] 190(2.0%) 190(2.0%) for-loop ...erbie/egg-cleanup/src/points.rkt:181:2 --------------------------------------------------------------------- ??? [30] 16.0% ??? [37] 84.0% [43] 2028(21.1%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-log [49] 57.1% ival-exp [52] 18.0% ??? [55] 16.0% ival-add [56] 8.9% --------------------------------------------------------------------- ??? [39] 5.9% ??? [5] 16.5% loop [44] 17.6% for-loop [22] 23.0% syntax-e/no-taint [9] 37.1% [44] 922(9.6%) 216(2.2%) loop (unknown source) gf [54] 37.1% ??? [37] 23.0% loop [44] 17.6% hash-ref! [66] 16.5% --------------------------------------------------------------------- for-loop [38] 100.0% [45] 668(6.9%) 0(0.0%) taylor-alt ...e/egg-cleanup/src/mainloop.rkt:146:0 for-loop [50] 100.0% --------------------------------------------------------------------- for-loop [46] 0.9% compile-forms33 [29] 33.7% finish-bodys [41] 65.4% [46] 516(5.4%) 0(0.0%) for-loop (unknown source) finish-bodys [41] 64.6% compile-module-linklet57 [57] 33.7% for-loop [46] 0.9% syntax-e [4] 0.9% --------------------------------------------------------------------- ??? [39] 100.0% [47] 378(3.9%) 0(0.0%) egraph-run ...gg-cleanup/src/core/eggmath.rkt:51:0 egraph-add-exprs [51] 100.0% --------------------------------------------------------------------- ??? [40] 100.0% [48] 354(3.7%) 0(0.0%) for-loop ...gg-cleanup/src/core/alt-table.rkt:55:2 atab-add-altn [53] 100.0% --------------------------------------------------------------------- ??? [43] 100.0% [49] 1158(12.0%) 1158(12.0%) ival-log .../egg-cleanup/src/biginterval.rkt:201:0 --------------------------------------------------------------------- taylor-alt [45] 100.0% [50] 668(6.9%) 0(0.0%) for-loop ...bie/egg-cleanup/src/mainloop.rkt:152:6 ??? [58] 100.0% --------------------------------------------------------------------- egraph-run [47] 100.0% [51] 378(3.9%) 0(0.0%) egraph-add-exprs ...nup/src/core/eggmath.rkt:113:0 ??? [59] 100.0% --------------------------------------------------------------------- ??? [43] 100.0% [52] 366(3.8%) 160(1.7%) ival-exp .../egg-cleanup/src/biginterval.rkt:191:0 bfexp [61] 56.3% --------------------------------------------------------------------- for-loop [48] 100.0% [53] 354(3.7%) 0(0.0%) atab-add-altn ...anup/src/core/alt-table.rkt:203:0 errors [62] 51.4% loop [63] 48.6% --------------------------------------------------------------------- loop [44] 100.0% [54] 342(3.6%) 0(0.0%) gf (unknown source) propagation-merge [60] 100.0% --------------------------------------------------------------------- ??? [43] 100.0% [55] 324(3.4%) 324(3.4%) ??? ...cts/racket/contract/private/list.rkt:209:10 --------------------------------------------------------------------- ??? [43] 100.0% [56] 180(1.9%) 180(1.9%) ival-add .../egg-cleanup/src/biginterval.rkt:101:0 --------------------------------------------------------------------- for-loop [46] 100.0% [57] 174(1.8%) 174(1.8%) compile-module-linklet57 (unknown source) --------------------------------------------------------------------- for-loop [78] 1.7% loop [74] 4.6% location-do [65] 4.6% for-loop [50] 4.6% ??? [37] 21.0% ??? [30] 63.6% [58] 4868(50.6%) 762(7.9%) ??? ...tract/private/arrow-higher-order.rkt:375:33 sample-multi-bounded [64] 55.7% mk-ival [68] 10.1% ival-mult [71] 6.5% location-do [65] 4.6% approximate9 [67] 4.6% hash-ref! [66] 4.6% --------------------------------------------------------------------- egraph-add-exprs [51] 100.0% [59] 378(3.9%) 0(0.0%) ??? ...rbie/egg-cleanup/src/core/simplify.rkt:93:6 for-loop [69] 100.0% --------------------------------------------------------------------- gf [54] 100.0% [60] 342(3.6%) 342(3.6%) propagation-merge (unknown source) --------------------------------------------------------------------- ival-exp [52] 100.0% [61] 206(2.1%) 0(0.0%) bfexp ...-lib/math/private/bigfloat/mpfr.rkt:632:4 ??? [70] 100.0% --------------------------------------------------------------------- atab-add-altn [53] 100.0% [62] 182(1.9%) 0(0.0%) errors .../herbie/egg-cleanup/src/points.rkt:201:0 for-loop [72] 100.0% --------------------------------------------------------------------- atab-add-altn [53] 100.0% [63] 172(1.8%) 172(1.8%) loop ...-7.5/collects/racket/private/hash.rkt:20:4 --------------------------------------------------------------------- ??? [58] 100.0% [64] 2794(29.1%) 736(7.7%) sample-multi-bounded ...leanup/src/points.rkt:15:0 random-ranges [73] 67.7% for-loop [78] 5.9% --------------------------------------------------------------------- ??? [58] 25.0% location-do [65] 75.0% [65] 668(6.9%) 0(0.0%) location-do ...e/egg-cleanup/src/programs.rkt:64:0 location-do [65] 75.0% ??? [58] 25.0% --------------------------------------------------------------------- loop [44] 3.8% ??? [5] 3.8% compile [12] 3.8% ??? [77] 15.5% for-loop [8] 18.6% ??? [75] 27.3% ??? [58] 27.3% [66] 668(6.9%) 152(1.6%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [75] 27.3% parse-loop75 [2] 27.3% ??? [3] 18.6% ??? [77] 15.5% ??? [5] 7.6% --------------------------------------------------------------------- ??? [58] 100.0% [67] 668(6.9%) 0(0.0%) approximate9 ...g-cleanup/src/core/taylor.rkt:12:0 loop [74] 100.0% --------------------------------------------------------------------- ??? [58] 100.0% [68] 492(5.1%) 0(0.0%) mk-ival ...ie/egg-cleanup/src/biginterval.rkt:65:0 bf [76] 100.0% --------------------------------------------------------------------- ??? [59] 100.0% [69] 378(3.9%) 378(3.9%) for-loop ...gg-cleanup/src/core/simplify.rkt:112:2 --------------------------------------------------------------------- loop [31] 42.5% bfexp [61] 57.5% [70] 358(3.7%) 358(3.7%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 --------------------------------------------------------------------- ??? [58] 100.0% [71] 318(3.3%) 318(3.3%) ival-mult ...egg-cleanup/src/biginterval.rkt:119:0 --------------------------------------------------------------------- errors [62] 100.0% [72] 182(1.9%) 182(1.9%) for-loop ...erbie/egg-cleanup/src/points.rkt:203:2 --------------------------------------------------------------------- sample-multi-bounded [64] 100.0% [73] 1892(19.7%) 0(0.0%) random-ranges .../egg-cleanup/src/common.rkt:171:0 cons/c [79] 91.4% build--> [81] 8.6% --------------------------------------------------------------------- approximate9 [67] 100.0% [74] 668(6.9%) 0(0.0%) loop ...erbie/egg-cleanup/src/core/taylor.rkt:87:4 ??? [58] 100.0% --------------------------------------------------------------------- hash-ref! [66] 100.0% [75] 668(6.9%) 0(0.0%) ??? ...erbie/egg-cleanup/src/core/taylor.rkt:45:15 hash-ref! [66] 100.0% --------------------------------------------------------------------- mk-ival [68] 100.0% [76] 492(5.1%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [80] 100.0% --------------------------------------------------------------------- hash-ref! [66] 100.0% [77] 356(3.7%) 0(0.0%) ??? ...rbie/egg-cleanup/src/core/taylor.rkt:344:33 hash-ref! [66] 100.0% --------------------------------------------------------------------- sample-multi-bounded [64] 100.0% [78] 166(1.7%) 0(0.0%) for-loop ...herbie/egg-cleanup/src/points.rkt:23:4 ??? [58] 100.0% --------------------------------------------------------------------- random-ranges [73] 100.0% [79] 1730(18.0%) 302(3.1%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [82] 82.5% --------------------------------------------------------------------- bf [76] 100.0% [80] 492(5.1%) 492(5.1%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 --------------------------------------------------------------------- random-ranges [73] 100.0% [81] 162(1.7%) 0(0.0%) build--> ...act/private/arrow-val-first.rkt:1214:0 chaperone-contract? [83] 100.0% --------------------------------------------------------------------- cons/c [79] 100.0% [82] 1428(14.9%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [84] 100.0% --------------------------------------------------------------------- build--> [81] 100.0% [83] 162(1.7%) 162(1.7%) chaperone-contract? ...ract/private/guts.rkt:135:0 --------------------------------------------------------------------- coerce-contract [82] 100.0% [84] 1428(14.9%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [85] 100.0% --------------------------------------------------------------------- coerce-contract/f [84] 100.0% [85] 1428(14.9%) 1428(14.9%) coerce-simple-value ...ract/private/guts.rkt:385:0 ---------------------------------------------------------------------