571.87890625 1907.260009765625 506.0869140625 Profiling results ----------------- Total cpu time observed: 117108ms (out of 119452ms) Number of samples taken: 227 (once every 516ms) (Hiding functions with self<1.0% and local<2.0%: 1 of 78 hidden) ========================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================= ??? [9] 100.0% [1] 117108(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [6] 100.0% ------------------------------------------------------------------------- hash-ref! [44] 100.0% [2] 21964(18.8%) 0(0.0%) ??? .../eggmath-testversion/src/programs.rkt:161:5 loop [27] 100.0% ------------------------------------------------------------------------- map [51] 100.0% [3] 342(0.3%) 0(0.0%) ??? ...ath-testversion/src/core/localize.rkt:58:36 ??? [8] 100.0% ------------------------------------------------------------------------- loop [74] 100.0% [4] 328(0.3%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [7] 100.0% ------------------------------------------------------------------------- for-loop [70] 100.0% [5] 320(0.3%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [7] 100.0% ------------------------------------------------------------------------- profile-thunk16 [1] 100.0% [6] 117108(100.0%) 0(0.0%) run ...et-7.2/share/pkgs/profile-lib/main.rkt:39:2 ??? [9] 100.0% ------------------------------------------------------------------------- syntax-e [5] 49.4% expand-id-application-form17 [4] 50.6% [7] 648(0.6%) 0(0.0%) syntax-e/no-taint (unknown source) loop [74] 100.0% ------------------------------------------------------------------------- ??? [3] 100.0% [8] 342(0.3%) 0(0.0%) ??? .../eggmath-testversion/src/interface.rkt:70:2 ??? [29] 100.0% ------------------------------------------------------------------------- for-loop [43] 0.1% run [6] 50.0% [9] 117108(100.0%) 294(0.3%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% loop [14] 37.9% run-improve47 [10] 10.9% get-final-combination [11] 0.7% eval-errors [12] 0.1% oracle-error [13] 0.1% errors [41] 0.1% ------------------------------------------------------------------------- ??? [9] 100.0% [10] 25646(21.9%) 0(0.0%) run-improve47 ...estversion/src/mainloop.rkt:345:0 for-loop [15] 57.3% loop [14] 35.1% simplify! [24] 7.7% ------------------------------------------------------------------------- ??? [9] 100.0% [11] 1734(1.5%) 0(0.0%) get-final-combination ...on/src/mainloop.rkt:370:0 ??? [16] 100.0% ------------------------------------------------------------------------- ??? [9] 100.0% [12] 290(0.2%) 0(0.0%) eval-errors ...th-testversion/src/points.rkt:179:0 for-loop [17] 100.0% ------------------------------------------------------------------------- ??? [9] 100.0% [13] 284(0.2%) 0(0.0%) oracle-error ...h-testversion/src/points.rkt:188:0 for-loop [18] 100.0% ------------------------------------------------------------------------- run-improve47 [10] 9.2% ??? [9] 90.8% [14] 97852(83.6%) 0(0.0%) loop ...e/eggmath-testversion/src/points.rkt:281:2 loop [19] 46.1% loop [23] 27.9% make-exacts-walkup [22] 26.0% ------------------------------------------------------------------------- run-improve47 [10] 100.0% [15] 14686(12.5%) 0(0.0%) for-loop ...ath-testversion/src/mainloop.rkt:364:4 run-iter! [20] 100.0% ------------------------------------------------------------------------- get-final-combination [11] 100.0% [16] 1734(1.5%) 0(0.0%) ??? ...math-testversion/src/core/simplify.rkt:25:0 ??? [28] 100.0% ------------------------------------------------------------------------- eval-errors [12] 100.0% [17] 290(0.2%) 0(0.0%) for-loop ...gmath-testversion/src/points.rkt:181:2 ??? [21] 100.0% ------------------------------------------------------------------------- oracle-error [13] 100.0% [18] 284(0.2%) 0(0.0%) for-loop ...gmath-testversion/src/points.rkt:189:2 map [51] 100.0% ------------------------------------------------------------------------- loop [14] 100.0% [19] 45126(38.5%) 0(0.0%) loop ...e/eggmath-testversion/src/points.rkt:244:2 make-exacts-walkup [22] 65.6% loop [23] 34.4% ------------------------------------------------------------------------- for-loop [15] 100.0% [20] 14686(12.5%) 0(0.0%) run-iter! ...th-testversion/src/mainloop.rkt:326:0 simplify! [24] 79.1% finalize-iter! [25] 13.8% localize! [26] 7.1% ------------------------------------------------------------------------- for-loop [17] 100.0% [21] 290(0.2%) 290(0.2%) ??? ...7.2/collects/racket/private/for.rkt:1233:14 ------------------------------------------------------------------------- loop [14] 46.2% loop [19] 53.8% [22] 55046(47.0%) 0(0.0%) make-exacts-walkup ...version/src/points.rkt:222:0 loop [27] 57.1% eval-prog [42] 42.9% ------------------------------------------------------------------------- loop [19] 36.2% loop [14] 63.8% [23] 42806(36.6%) 0(0.0%) loop ...e/eggmath-testversion/src/points.rkt:227:4 loop [27] 99.1% composed [31] 0.9% ------------------------------------------------------------------------- run-improve47 [10] 14.5% run-iter! [20] 85.5% [24] 13582(11.6%) 0(0.0%) simplify! ...th-testversion/src/mainloop.rkt:223:0 ??? [28] 100.0% ------------------------------------------------------------------------- run-iter! [20] 100.0% [25] 2024(1.7%) 0(0.0%) finalize-iter! ...stversion/src/mainloop.rkt:277:0 ??? [29] 100.0% ------------------------------------------------------------------------- run-iter! [20] 100.0% [26] 1048(0.9%) 0(0.0%) localize! ...th-testversion/src/mainloop.rkt:126:0 localize-error [30] 100.0% ------------------------------------------------------------------------- map [51] 0.0% make-exacts-walkup [22] 0.1% loop [23] 0.4% ??? [2] 22.8% loop [27] 76.7% [27] 96184(82.1%) 0(0.0%) loop ...-7.2/collects/racket/private/map.rkt:40:19 loop [27] 76.7% hash-ref! [44] 22.8% composed [31] 0.5% ??? [53] 0.0% ------------------------------------------------------------------------- ??? [16] 11.3% simplify! [24] 88.7% [28] 15316(13.1%) 0(0.0%) ??? ...math-testversion/src/core/simplify.rkt:38:0 egraph-run [32] 100.0% ------------------------------------------------------------------------- ??? [8] 14.5% finalize-iter! [25] 85.5% [29] 2366(2.0%) 342(0.3%) ??? ...contract/private/arrow-val-first.rkt:390:18 for-loop [33] 72.0% atab-add-altns [34] 13.5% ------------------------------------------------------------------------- localize! [26] 100.0% [30] 1048(0.9%) 0(0.0%) localize-error ...rsion/src/core/localize.rkt:66:0 hash-ref! [44] 100.0% ------------------------------------------------------------------------- loop [23] 0.5% loop [27] 99.5% [31] 74236(63.4%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 ??? [35] 100.0% ------------------------------------------------------------------------- ??? [28] 100.0% [32] 15316(13.1%) 0(0.0%) egraph-run ...estversion/src/core/eggmath.rkt:54:0 egraph-add-exprs [36] 100.0% ------------------------------------------------------------------------- ??? [29] 100.0% [33] 1704(1.5%) 0(0.0%) for-loop ...estversion/src/core/alt-table.rkt:55:2 atab-add-altn [37] 100.0% ------------------------------------------------------------------------- ??? [29] 100.0% [34] 320(0.3%) 0(0.0%) atab-add-altns ...sion/src/core/alt-table.rkt:49:0 atab-add-altn [37] 100.0% ------------------------------------------------------------------------- composed [31] 100.0% [35] 74236(63.4%) 0(0.0%) ??? .../eggmath-testversion/src/programs.rkt:115:2 ??? [38] 100.0% ------------------------------------------------------------------------- egraph-run [32] 100.0% [36] 15316(13.1%) 0(0.0%) egraph-add-exprs ...ion/src/core/eggmath.rkt:118:0 ??? [39] 62.2% for-loop [40] 37.8% ------------------------------------------------------------------------- atab-add-altns [34] 15.8% for-loop [33] 84.2% [37] 2024(1.7%) 0(0.0%) atab-add-altn ...sion/src/core/alt-table.rkt:203:0 errors [41] 100.0% ------------------------------------------------------------------------- ??? [35] 100.0% [38] 74236(63.4%) 346(0.3%) ??? ...t-7.2/collects/racket/private/kw.rkt:594:14 ??? [53] 91.8% ??? [65] 7.3% ------------------------------------------------------------------------- egraph-add-exprs [36] 100.0% [39] 9524(8.1%) 9524(8.1%) ??? ...math-testversion/src/core/simplify.rkt:49:8 ------------------------------------------------------------------------- egraph-add-exprs [36] 100.0% [40] 5792(4.9%) 5792(4.9%) for-loop ...testversion/src/core/eggmath.rkt:124:4 ------------------------------------------------------------------------- ??? [9] 12.7% atab-add-altn [37] 87.3% [41] 2318(2.0%) 0(0.0%) errors ...eggmath-testversion/src/points.rkt:205:0 eval-prog [42] 87.3% for-loop [43] 12.7% ------------------------------------------------------------------------- errors [41] 7.9% make-exacts-walkup [22] 92.1% [42] 25640(21.9%) 0(0.0%) eval-prog ...ath-testversion/src/programs.rkt:83:0 hash-ref! [44] 90.8% temp85_0 [45] 9.2% ------------------------------------------------------------------------- errors [41] 100.0% [43] 294(0.3%) 0(0.0%) for-loop ...gmath-testversion/src/points.rkt:207:2 ??? [9] 100.0% ------------------------------------------------------------------------- localize-error [30] 1.1% map [51] 3.2% eval-prog [42] 23.5% loop [27] 72.2% [44] 24336(20.8%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 72.2% bigfloat-hash [46] 23.5% parse-loop30 [48] 4.3% ------------------------------------------------------------------------- eval-prog [42] 100.0% [45] 2352(2.0%) 0(0.0%) temp85_0 (unknown source) compile15 [47] 100.0% ------------------------------------------------------------------------- hash-ref! [44] 100.0% [46] 23288(19.9%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 bfcanonicalize [49] 94.6% sig+exp->bigfloat [52] 5.4% ------------------------------------------------------------------------- temp85_0 [45] 100.0% [47] 2352(2.0%) 0(0.0%) compile15 (unknown source) temp91_0 [50] 100.0% ------------------------------------------------------------------------- hash-ref! [44] 100.0% [48] 1048(0.9%) 0(0.0%) parse-loop30 ...s/racket/match/compiler.rkt:418:15 map [51] 100.0% ------------------------------------------------------------------------- bigfloat-hash [46] 100.0% [49] 22020(18.8%) 20976(17.9%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 bigfloat->sig+exp [55] 4.7% ------------------------------------------------------------------------- compile15 [47] 100.0% [50] 2352(2.0%) 0(0.0%) temp91_0 (unknown source) temp118_0 [54] 100.0% ------------------------------------------------------------------------- for-loop [18] 21.3% parse-loop30 [48] 78.7% [51] 1332(1.1%) 0(0.0%) map ...t-7.2/collects/racket/private/map.rkt:35:13 hash-ref! [44] 58.2% ??? [57] 21.3% ??? [53] 13.1% loop [27] 4.5% ??? [3] 2.9% ------------------------------------------------------------------------- bigfloat-hash [46] 100.0% [52] 1268(1.1%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:387:0 new-mpfr [71] 72.1% integer->mpz [56] 27.9% ------------------------------------------------------------------------- map [51] 0.5% loop [27] 0.5% ??? [38] 99.0% [53] 68854(58.8%) 736(0.6%) ??? ...tract/private/arrow-higher-order.rkt:364:33 bf-complex-mult [58] 93.4% bf-complex-add [59] 5.5% ------------------------------------------------------------------------- temp91_0 [50] 100.0% [54] 2352(2.0%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [60] 100.0% ------------------------------------------------------------------------- bfcanonicalize [49] 100.0% [55] 1044(0.9%) 692(0.6%) bigfloat->sig+exp ...ivate/bigfloat/mpfr.rkt:372:0 size+limbs->integer [61] 33.7% ------------------------------------------------------------------------- sig+exp->bigfloat [52] 100.0% [56] 354(0.3%) 354(0.3%) integer->mpz ...math/private/bigfloat/gmp.rkt:87:0 ------------------------------------------------------------------------- map [51] 100.0% [57] 284(0.2%) 284(0.2%) ??? ...e/eggmath-testversion/src/points.rkt:190:26 ------------------------------------------------------------------------- ??? [53] 100.0% [58] 64300(54.9%) 1520(1.3%) bf-complex-mult ...version/src/bigcomplex.rkt:30:0 bf* [62] 54.6% ??? [65] 40.6% ...higher-order.rkt:364:33 [64] 2.4% ------------------------------------------------------------------------- ??? [53] 100.0% [59] 3818(3.3%) 0(0.0%) bf-complex-add ...tversion/src/bigcomplex.rkt:23:0 ??? [65] 100.0% ------------------------------------------------------------------------- temp118_0 [54] 100.0% [60] 2352(2.0%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [63] 100.0% ------------------------------------------------------------------------- bigfloat->sig+exp [55] 100.0% [61] 352(0.3%) 352(0.3%) size+limbs->integer ...vate/bigfloat/gmp.rkt:103:0 ------------------------------------------------------------------------- bf-complex-mult [58] 100.0% [62] 35078(30.0%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [65] 100.0% ------------------------------------------------------------------------- expand-capturing-lifts [60] 100.0% [63] 2352(2.0%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [66] 100.0% ------------------------------------------------------------------------- bf-complex-mult [58] 100.0% [64] 1574(1.3%) 836(0.7%) ...higher-order.rkt:364:33 (unknown source) ??? [67] 46.9% ------------------------------------------------------------------------- bf-complex-add [59] 5.4% ??? [38] 7.7% bf-complex-mult [58] 37.1% bf* [62] 49.8% [65] 70436(60.1%) 5320(4.5%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfadd [68] 74.7% bfneg [69] 17.8% ------------------------------------------------------------------------- lambda-clause-expander [63] 3.4% for-loop [70] 96.6% [66] 2352(2.0%) 0(0.0%) finish-bodys (unknown source) for-loop [70] 100.0% ------------------------------------------------------------------------- ...higher-order.rkt:364:33 [64] 100.0% [67] 738(0.6%) 738(0.6%) ??? ...cts/racket/contract/private/list.rkt:209:10 ------------------------------------------------------------------------- ??? [65] 100.0% [68] 52586(44.9%) 1382(1.2%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [71] 72.2% ??? [72] 25.1% ------------------------------------------------------------------------- ??? [65] 100.0% [69] 12530(10.7%) 384(0.3%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [71] 66.3% ??? [72] 30.6% ------------------------------------------------------------------------- for-loop [70] 3.9% finish-bodys [66] 96.1% [70] 2352(2.0%) 0(0.0%) for-loop (unknown source) finish-bodys [66] 92.8% for-loop [70] 3.9% add-local-binding!39 [73] 1.9% loop [74] 1.3% syntax-e [5] 0.2% ------------------------------------------------------------------------- sig+exp->bigfloat [52] 1.9% bfneg [69] 17.6% bfadd [68] 80.5% [71] 47214(40.3%) 47214(40.3%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------- bfneg [69] 22.5% bfadd [68] 77.5% [72] 17050(14.6%) 17050(14.6%) ??? /opt/racket-7.2/collects/ffi/unsafe.rkt:905:4 ------------------------------------------------------------------------- for-loop [70] 100.0% [73] 1704(1.5%) 1704(1.5%) add-local-binding!39 (unknown source) ------------------------------------------------------------------------- for-loop [70] 25.3% syntax-e/no-taint [7] 74.7% [74] 648(0.6%) 0(0.0%) loop (unknown source) gf [75] 74.7% expand-id-application-form17 [4] 25.3% ------------------------------------------------------------------------- loop [74] 100.0% [75] 648(0.6%) 0(0.0%) gf (unknown source) propagation-apply-shifted [76] 50.6% propagation-merge [77] 49.4% ------------------------------------------------------------------------- gf [75] 100.0% [76] 328(0.3%) 328(0.3%) propagation-apply-shifted (unknown source) ------------------------------------------------------------------------- gf [75] 100.0% [77] 320(0.3%) 320(0.3%) propagation-merge (unknown source) -------------------------------------------------------------------------