Profiling results ----------------- Total cpu time observed: 15834ms (out of 15976ms) Number of samples taken: 70 (once every 226ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== [1] 15834(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [5] 100.0% ---------------------------------------------------------------------- hash-ref! [47] 100.0% [2] 3284(20.7%) 0(0.0%) ??? ...egg-herbie-constants/src/programs.rkt:161:5 loop [24] 100.0% ---------------------------------------------------------------------- matcher [50] 100.0% [3] 336(2.1%) 0(0.0%) ??? ...erbie-constants/src/core/matcher.rkt:130:11 for-loop [6] 100.0% ---------------------------------------------------------------------- for-loop [86] 100.0% [4] 208(1.3%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [7] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [5] 15834(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [8] 100.0% ---------------------------------------------------------------------- ??? [3] 100.0% [6] 336(2.1%) 0(0.0%) for-loop ...-constants/src/core/matcher.rkt:132:15 matcher [50] 100.0% ---------------------------------------------------------------------- expand-identifier [4] 100.0% [7] 208(1.3%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [9] 100.0% ---------------------------------------------------------------------- profile-thunk16 [5] 100.0% [8] 15834(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [10]100.0% ---------------------------------------------------------------------- resolve+shift28 [7] 100.0% [9] 208(1.3%) 0(0.0%) fallback-loop (unknown source) for-loop [86] 100.0% ---------------------------------------------------------------------- for-loop [45] 0.7% run [8] 99.3% [10] 15834(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) loop [13] 80.7% run-improve47 [11] 16.8% oracle-error [12] 1.2% errors [35] 0.7% ??? [34] 0.7% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10]100.0% [11] 2654(16.8%) 0(0.0%) run-improve47 ...-constants/src/mainloop.rkt:346:0 loop [13] 49.2% for-loop [14] 43.0% ??? [25] 7.8% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10]100.0% [12] 192(1.2%) 0(0.0%) oracle-error ...bie-constants/src/points.rkt:188:0 for-loop [15] 100.0% ---------------------------------------------------------------------- run-improve47 [11] 9.3% .../more-scheme.rkt:261:28 [10] 90.7% [13] 14078(88.9%) 0(0.0%) loop ...-egg-herbie-constants/src/points.rkt:277:2 loop [16] 46.2% make-exacts-walkup [18] 29.4% loop [19] 24.3% ---------------------------------------------------------------------- run-improve47 [11] 100.0% [14] 1140(7.2%) 0(0.0%) for-loop ...erbie-constants/src/mainloop.rkt:365:4 run-iter! [17] 100.0% ---------------------------------------------------------------------- oracle-error [12] 100.0% [15] 192(1.2%) 0(0.0%) for-loop ...-herbie-constants/src/points.rkt:189:2 loop [24] 100.0% ---------------------------------------------------------------------- loop [13] 100.0% [16] 6510(41.1%) 0(0.0%) loop ...-egg-herbie-constants/src/points.rkt:240:2 make-exacts-walkup [18] 73.5% loop [19] 26.5% ---------------------------------------------------------------------- for-loop [14] 100.0% [17] 1140(7.2%) 0(0.0%) run-iter! ...rbie-constants/src/mainloop.rkt:327:0 simplify! [20] 30.9% gen-rewrites! [21] 29.5% finalize-iter! [22] 21.1% localize! [23] 18.6% ---------------------------------------------------------------------- loop [13] 46.4% loop [16] 53.6% [18] 8928(56.4%) 0(0.0%) make-exacts-walkup ...nstants/src/points.rkt:218:0 loop [24] 63.2% eval-prog [40] 36.8% ---------------------------------------------------------------------- loop [16] 33.5% loop [13] 66.5% [19] 5150(32.5%) 0(0.0%) loop ...-egg-herbie-constants/src/points.rkt:223:4 loop [24] 100.0% ---------------------------------------------------------------------- run-iter! [17] 100.0% [20] 352(2.2%) 0(0.0%) simplify! ...rbie-constants/src/mainloop.rkt:224:0 egraph-run [26] 100.0% ---------------------------------------------------------------------- run-iter! [17] 100.0% [21] 336(2.1%) 0(0.0%) gen-rewrites! ...-constants/src/mainloop.rkt:183:0 for-loop [27] 100.0% ---------------------------------------------------------------------- run-iter! [17] 100.0% [22] 240(1.5%) 0(0.0%) finalize-iter! ...constants/src/mainloop.rkt:278:0 ??? [25] 100.0% ---------------------------------------------------------------------- run-iter! [17] 100.0% [23] 212(1.3%) 0(0.0%) localize! ...rbie-constants/src/mainloop.rkt:127:0 localize-error [28] 100.0% ---------------------------------------------------------------------- make-exacts-walkup [18] 0.2% loop [19] 0.2% for-loop [15] 1.3% ??? [2] 23.0% loop [24] 75.2% [24] 14270(90.1%) 0(0.0%) loop (unknown source) loop [24] 75.2% hash-ref! [47] 23.0% ??? [34] 1.3% composed [29] 0.4% ---------------------------------------------------------------------- run-improve47 [11] 46.4% finalize-iter! [22] 53.6% [25] 448(2.8%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [32] 53.6% make-alt-table [33] 46.4% ---------------------------------------------------------------------- simplify! [20] 100.0% [26] 352(2.2%) 0(0.0%) egraph-run ...-constants/src/core/eggmath.rkt:51:0 egraph-add-exprs [30] 100.0% ---------------------------------------------------------------------- gen-rewrites! [21] 100.0% [27] 336(2.1%) 0(0.0%) for-loop ...rbie-constants/src/mainloop.rkt:191:11 rewrite-expression-head20 [31] 100.0% ---------------------------------------------------------------------- localize! [23] 100.0% [28] 212(1.3%) 0(0.0%) localize-error ...tants/src/core/localize.rkt:66:0 hash-ref! [47] 100.0% ---------------------------------------------------------------------- loop [24] 100.0% [29] 10794(68.2%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 ??? [34] 100.0% ---------------------------------------------------------------------- egraph-run [26] 100.0% [30] 352(2.2%) 0(0.0%) egraph-add-exprs ...nts/src/core/eggmath.rkt:113:0 ??? [36] 100.0% ---------------------------------------------------------------------- for-loop [27] 100.0% [31] 336(2.1%) 0(0.0%) rewrite-expression-head20 ...core/matcher.rkt:87:0 rewriter [37] 100.0% ---------------------------------------------------------------------- ??? [25] 100.0% [32] 240(1.5%) 0(0.0%) for-loop ...-constants/src/core/alt-table.rkt:55:2 atab-add-altn [38] 100.0% ---------------------------------------------------------------------- ??? [25] 100.0% [33] 208(1.3%) 0(0.0%) make-alt-table ...ants/src/core/alt-table.rkt:32:0 errors [35] 100.0% ---------------------------------------------------------------------- loop [24] 1.7% .../more-scheme.rkt:261:28 [10] 1.9% composed [29] 96.4% [34] 11202(70.7%) 692(4.4%) ??? ...egg-herbie-constants/src/programs.rkt:115:2 ??? [39] 86.2% ??? [61] 3.9% ??? [41] 3.6% ---------------------------------------------------------------------- make-alt-table [33] 49.1% .../more-scheme.rkt:261:28 [10] 50.9% [35] 424(2.7%) 0(0.0%) errors ...gg-herbie-constants/src/points.rkt:201:0 for-loop [45] 50.9% eval-prog [40] 49.1% ---------------------------------------------------------------------- egraph-add-exprs [30] 100.0% [36] 352(2.2%) 0(0.0%) ??? ...herbie-constants/src/core/simplify.rkt:72:6 for-loop [42] 100.0% ---------------------------------------------------------------------- rewrite-expression-head20 [31] 25.0% matcher [50] 75.0% [37] 336(2.1%) 0(0.0%) rewriter ...ie-constants/src/core/matcher.rkt:90:2 for-loop [43] 100.0% ---------------------------------------------------------------------- for-loop [32] 100.0% [38] 240(1.5%) 0(0.0%) atab-add-altn ...ants/src/core/alt-table.rkt:203:0 append-at-pnts [44] 100.0% ---------------------------------------------------------------------- ??? [34] 100.0% [39] 9660(61.0%) 222(1.4%) ??? ...tract/private/arrow-higher-order.rkt:379:33 bf-complex-mult [46] 88.4% bf-complex-add [48] 9.3% ---------------------------------------------------------------------- errors [35] 6.0% make-exacts-walkup [18] 94.0% [40] 3492(22.1%) 0(0.0%) eval-prog ...erbie-constants/src/programs.rkt:83:0 hash-ref! [47] 94.0% temp85_0 [52] 6.0% ---------------------------------------------------------------------- ??? [34] 100.0% [41] 408(2.6%) 216(1.4%) ??? ...rbie-constants/src/syntax/syntax.rkt:214:17 return/no-unsupplied [53] 47.1% ---------------------------------------------------------------------- ??? [36] 100.0% [42] 352(2.2%) 352(2.2%) for-loop ...e-constants/src/core/simplify.rkt:91:2 ---------------------------------------------------------------------- rewriter [37] 100.0% [43] 336(2.1%) 0(0.0%) for-loop ...ie-constants/src/core/matcher.rkt:92:4 matcher [50] 75.0% for-loop [49] 25.0% ---------------------------------------------------------------------- atab-add-altn [38] 100.0% [44] 240(1.5%) 0(0.0%) append-at-pnts ...nts/src/core/alt-table.rkt:146:0 loop [51] 100.0% ---------------------------------------------------------------------- errors [35] 100.0% [45] 216(1.4%) 0(0.0%) for-loop ...-herbie-constants/src/points.rkt:203:2 .../more-scheme.rkt:261:28 [10]100.0% ---------------------------------------------------------------------- ??? [39] 100.0% [46] 8538(53.9%) 432(2.7%) bf-complex-mult ...nstants/src/bigcomplex.rkt:30:0 bf* [54] 52.4% ??? [61] 39.8% ...higher-order.rkt:379:33 [57] 2.8% ---------------------------------------------------------------------- localize-error [28] 1.0% map [67] 5.1% eval-prog [40] 22.0% loop [24] 71.9% [47] 3496(22.1%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 71.9% bigfloat-hash [55] 22.0% parse-loop30 [58] 6.1% ---------------------------------------------------------------------- ??? [39] 100.0% [48] 900(5.7%) 0(0.0%) bf-complex-add ...onstants/src/bigcomplex.rkt:23:0 ??? [61] 100.0% ---------------------------------------------------------------------- for-loop [43] 100.0% [49] 336(2.1%) 0(0.0%) for-loop ...ie-constants/src/core/matcher.rkt:99:8 fix-up-variables [56] 100.0% ---------------------------------------------------------------------- for-loop [6] 50.0% for-loop [43] 50.0% [50] 336(2.1%) 0(0.0%) matcher ...ie-constants/src/core/matcher.rkt:118:2 ??? [3] 50.0% rewriter [37] 50.0% ---------------------------------------------------------------------- append-at-pnts [44] 100.0% [51] 240(1.5%) 240(1.5%) loop ...bie-constants/src/core/alt-table.rkt:101:2 ---------------------------------------------------------------------- eval-prog [40] 100.0% [52] 208(1.3%) 0(0.0%) temp85_0 (unknown source) compile15 [59] 100.0% ---------------------------------------------------------------------- ??? [41] 100.0% [53] 192(1.2%) 0(0.0%) return/no-unsupplied ...ct/private/arr-i.rkt:566:0 filter [60] 100.0% ---------------------------------------------------------------------- bf-complex-mult [46] 100.0% [54] 4470(28.2%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [61] 100.0% ---------------------------------------------------------------------- hash-ref! [47] 100.0% [55] 3284(20.7%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:168:0 bfcanonicalize [62] 86.6% sig+exp->bigfloat [63] 13.4% ---------------------------------------------------------------------- for-loop [49] 100.0% [56] 336(2.1%) 0(0.0%) fix-up-variables ...nts/src/core/matcher.rkt:111:2 pattern-match [64] 100.0% ---------------------------------------------------------------------- bf-complex-mult [46] 100.0% [57] 240(1.5%) 0(0.0%) ...higher-order.rkt:379:33 (unknown source) ??? [65] 100.0% ---------------------------------------------------------------------- hash-ref! [47] 100.0% [58] 212(1.3%) 0(0.0%) parse-loop30 (unknown source) map [67] 83.3% for-loop [66] 16.7% ---------------------------------------------------------------------- temp85_0 [52] 100.0% [59] 208(1.3%) 0(0.0%) compile15 (unknown source) temp91_0 [68] 100.0% ---------------------------------------------------------------------- return/no-unsupplied [53] 100.0% [60] 192(1.2%) 192(1.2%) filter ...5/collects/racket/private/list.rkt:256:2 ---------------------------------------------------------------------- ??? [34] 4.8% bf-complex-add [48] 9.8% bf-complex-mult [46] 36.9% bf* [54] 48.5% [61] 9208(58.2%) 1342(8.5%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [69] 78.2% bfneg [70] 7.3% ---------------------------------------------------------------------- bigfloat-hash [55] 100.0% [62] 2844(18.0%) 2622(16.6%) bfcanonicalize .../private/bigfloat/mpfr.rkt:158:0 bigfloat->sig+exp [73] 7.8% ---------------------------------------------------------------------- bigfloat-hash [55] 100.0% [63] 440(2.8%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:401:0 new-mpfr [77] 50.5% integer->mpz [74] 49.5% ---------------------------------------------------------------------- fix-up-variables [56] 100.0% [64] 336(2.1%) 0(0.0%) pattern-match ...nstants/src/core/matcher.rkt:30:0 for-loop [71] 100.0% ---------------------------------------------------------------------- ...higher-order.rkt:379:33 [57]100.0% [65] 240(1.5%) 0(0.0%) ??? ...cts/racket/contract/private/list.rkt:209:10 ??? [72] 100.0% ---------------------------------------------------------------------- parse-loop30 [58] 100.0% [66] 212(1.3%) 0(0.0%) for-loop ...-constants/src/core/localize.rkt:53:21 for-loop [75] 100.0% ---------------------------------------------------------------------- parse-loop30 [58] 100.0% [67] 212(1.3%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 hash-ref! [47] 100.0% ---------------------------------------------------------------------- compile15 [59] 100.0% [68] 208(1.3%) 0(0.0%) temp91_0 (unknown source) temp118_0 [76] 100.0% ---------------------------------------------------------------------- ??? [61] 100.0% [69] 7198(45.5%) 440(2.8%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [77] 56.2% ??? [78] 37.6% ---------------------------------------------------------------------- ??? [61] 100.0% [70] 668(4.2%) 0(0.0%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:632:4 new-mpfr [77] 63.8% ??? [78] 36.2% ---------------------------------------------------------------------- pattern-match [64] 100.0% [71] 336(2.1%) 0(0.0%) for-loop ...ie-constants/src/core/matcher.rkt:27:9 core457 [79] 100.0% ---------------------------------------------------------------------- ??? [65] 100.0% [72] 240(1.5%) 240(1.5%) ??? ...ects/racket/contract/private/guts.rkt:770:8 ---------------------------------------------------------------------- bfcanonicalize [62] 100.0% [73] 222(1.4%) 222(1.4%) bigfloat->sig+exp ...ivate/bigfloat/mpfr.rkt:386:0 ---------------------------------------------------------------------- sig+exp->bigfloat [63] 100.0% [74] 218(1.4%) 218(1.4%) integer->mpz ...math/private/bigfloat/gmp.rkt:87:0 ---------------------------------------------------------------------- for-loop [66] 100.0% [75] 212(1.3%) 0(0.0%) for-loop ...-constants/src/core/localize.rkt:54:23 ??? [80] 100.0% ---------------------------------------------------------------------- temp91_0 [68] 100.0% [76] 208(1.3%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [81] 100.0% ---------------------------------------------------------------------- sig+exp->bigfloat [63] 4.7% bfneg [70] 9.1% bfmul [69] 86.2% [77] 4696(29.7%) 4696(29.7%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ---------------------------------------------------------------------- bfneg [70] 8.2% bfmul [69] 91.8% [78] 2952(18.6%) 2952(18.6%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ---------------------------------------------------------------------- for-loop [71] 100.0% [79] 336(2.1%) 0(0.0%) core457 ...acket/contract/private/arr-i.rkt:976:19 arrow-higher-order:lnp [82] 100.0% ---------------------------------------------------------------------- for-loop [75] 100.0% [80] 212(1.3%) 212(1.3%) ??? ...egg-herbie-constants/src/interface.rkt:76:2 ---------------------------------------------------------------------- temp118_0 [76] 100.0% [81] 208(1.3%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [83] 100.0% ---------------------------------------------------------------------- core457 [79] 100.0% [82] 336(2.1%) 0(0.0%) arrow-higher-order:lnp ...w-higher-order.rkt:673:7 ??? [84] 100.0% ---------------------------------------------------------------------- expand-capturing-lifts [81] 100.0% [83] 208(1.3%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [85] 100.0% ---------------------------------------------------------------------- arrow-higher-order:lnp [82] 100.0% [84] 336(2.1%) 336(2.1%) ??? ...et/contract/private/arity-checking.rkt:19:2 ---------------------------------------------------------------------- lambda-clause-expander [83] 8.3% for-loop [86] 91.7% [85] 208(1.3%) 0(0.0%) finish-bodys (unknown source) for-loop [86] 100.0% ---------------------------------------------------------------------- fallback-loop [9] 6.7% for-loop [86] 13.3% finish-bodys [85] 80.0% [86] 208(1.3%) 208(1.3%) for-loop (unknown source) finish-bodys [85] 73.3% for-loop [86] 13.3% expand-identifier [4] 6.7% ----------------------------------------------------------------------