Profiling results ----------------- Total cpu time observed: 23404ms (out of 23904ms) Number of samples taken: 75 (once every 312ms) ======================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================= ??? [11] 100.0% [1] 23404(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [6] 100.0% ----------------------------------------------------------------------- ??? [11] 100.0% [2] 4562(19.5%) 0(0.0%) run-improve40 ...ivate-mpfr/src/mainloop.rkt:336:0 for-loop [7] 93.5% loop [15] 6.5% ----------------------------------------------------------------------- ??? [11] 100.0% [3] 2504(10.7%) 0(0.0%) oracle-error ...-private-mpfr/src/points.rkt:212:0 for-loop [8] 100.0% ----------------------------------------------------------------------- ??? [11] 100.0% [4] 966(4.1%) 0(0.0%) get-final-combination ...fr/src/mainloop.rkt:357:0 infer-splitpoints [9] 100.0% ----------------------------------------------------------------------- for-loop [108] 100.0% [5] 334(1.4%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [10] 100.0% ----------------------------------------------------------------------- profile-thunk16 [1] 100.0% [6] 23404(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [11] 100.0% ----------------------------------------------------------------------- run-improve40 [2] 100.0% [7] 4266(18.2%) 0(0.0%) for-loop ...al-private-mpfr/src/mainloop.rkt:351:4 run-iter! [12] 100.0% ----------------------------------------------------------------------- oracle-error [3] 100.0% [8] 2504(10.7%) 0(0.0%) for-loop ...ival-private-mpfr/src/points.rkt:213:2 loop [50] 80.0% map [46] 20.0% ----------------------------------------------------------------------- get-final-combination [4] 100.0% [9] 966(4.1%) 0(0.0%) infer-splitpoints ...pfr/src/core/regimes.rkt:34:0 for-loop [13] 100.0% ----------------------------------------------------------------------- expand-identifier [5] 100.0% [10] 334(1.4%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [14] 100.0% ----------------------------------------------------------------------- run [6] 50.0% [11] 23404(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% loop [15] 24.9% run-improve40 [2] 9.7% oracle-error [3] 5.3% eval-errors [16] 4.4% errors [45] 3.5% get-final-combination [4] 2.1% ----------------------------------------------------------------------- for-loop [7] 100.0% [12] 4266(18.2%) 0(0.0%) run-iter! ...l-private-mpfr/src/mainloop.rkt:317:0 finalize-iter! [17] 46.4% localize! [18] 27.4% simplify! [19] 26.2% ----------------------------------------------------------------------- infer-splitpoints [9] 100.0% [13] 966(4.1%) 0(0.0%) for-loop ...private-mpfr/src/core/regimes.rkt:46:6 option-on-expr [20] 100.0% ----------------------------------------------------------------------- resolve+shift28 [10] 100.0% [14] 334(1.4%) 0(0.0%) fallback-loop (unknown source) for-loop [108] 100.0% ----------------------------------------------------------------------- run-improve40 [2] 2.5% ??? [11] 97.5% [15] 11954(51.1%) 0(0.0%) loop ...bie/ival-private-mpfr/src/points.rkt:303:2 loop [30] 68.7% loop [21] 26.3% for-loop [28] 2.5% filter-p&e [29] 2.5% ----------------------------------------------------------------------- ??? [11] 100.0% [16] 2062(8.8%) 0(0.0%) eval-errors ...l-private-mpfr/src/points.rkt:203:0 for-loop [22] 100.0% ----------------------------------------------------------------------- run-iter! [12] 100.0% [17] 1978(8.5%) 0(0.0%) finalize-iter! ...vate-mpfr/src/mainloop.rkt:268:0 ??? [23] 100.0% ----------------------------------------------------------------------- run-iter! [12] 100.0% [18] 1170(5.0%) 0(0.0%) localize! ...l-private-mpfr/src/mainloop.rkt:116:0 localize-error [24] 100.0% ----------------------------------------------------------------------- run-iter! [12] 100.0% [19] 1118(4.8%) 0(0.0%) simplify! ...l-private-mpfr/src/mainloop.rkt:213:0 ??? [25] 100.0% ----------------------------------------------------------------------- for-loop [13] 100.0% [20] 966(4.1%) 0(0.0%) option-on-expr ...-mpfr/src/core/regimes.rkt:150:0 sort-context-on-expr [26] 65.4% for-loop [27] 34.6% ----------------------------------------------------------------------- loop [15] 100.0% [21] 3146(13.4%) 0(0.0%) loop ...bie/ival-private-mpfr/src/points.rkt:264:2 make-exacts-walkup [32] 59.8% loop [30] 40.2% ----------------------------------------------------------------------- eval-errors [16] 100.0% [22] 2062(8.8%) 0(0.0%) for-loop ...ival-private-mpfr/src/points.rkt:205:2 ??? [66] 63.1% ??? [73] 24.3% ??? [37] 12.5% ----------------------------------------------------------------------- finalize-iter! [17] 100.0% [23] 1978(8.5%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [31] 100.0% ----------------------------------------------------------------------- localize! [18] 100.0% [24] 1170(5.0%) 0(0.0%) localize-error ...-mpfr/src/core/localize.rkt:52:0 hash-ref! [33] 100.0% ----------------------------------------------------------------------- simplify! [19] 100.0% [25] 1118(4.8%) 0(0.0%) ??? ...val-private-mpfr/src/core/simplify.rkt:26:0 for-loop [34] 100.0% ----------------------------------------------------------------------- option-on-expr [20] 100.0% [26] 632(2.7%) 0(0.0%) sort-context-on-expr ...src/core/regimes.rkt:145:0 ??? [35] 100.0% ----------------------------------------------------------------------- option-on-expr [20] 100.0% [27] 334(1.4%) 0(0.0%) for-loop ...rivate-mpfr/src/core/regimes.rkt:158:4 errors [45] 100.0% ----------------------------------------------------------------------- loop [15] 100.0% [28] 300(1.3%) 0(0.0%) for-loop ...val-private-mpfr/src/points.rkt:322:31 for-loop [36] 100.0% ----------------------------------------------------------------------- loop [15] 100.0% [29] 296(1.3%) 296(1.3%) filter-p&e ...al-private-mpfr/src/points.rkt:277:0 ----------------------------------------------------------------------- loop [21] 13.3% loop [15] 86.7% [30] 9476(40.5%) 0(0.0%) loop ...bie/ival-private-mpfr/src/points.rkt:247:4 loop [50] 100.0% ----------------------------------------------------------------------- ??? [23] 100.0% [31] 1978(8.5%) 0(0.0%) for-loop ...ivate-mpfr/src/core/alt-table.rkt:56:2 atab-add-altn [38] 86.3% loop [44] 13.7% ----------------------------------------------------------------------- loop [21] 100.0% [32] 1882(8.0%) 0(0.0%) make-exacts-walkup ...te-mpfr/src/points.rkt:244:0 loop [50] 100.0% ----------------------------------------------------------------------- loop [50] 8.1% localize-error [24] 35.5% map [46] 56.4% [33] 1170(5.0%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 f9 [39] 56.4% parse-loop15 [40] 43.6% ----------------------------------------------------------------------- ??? [25] 100.0% [34] 1118(4.8%) 0(0.0%) for-loop ...rivate-mpfr/src/core/simplify.rkt:33:2 one-iter [41] 100.0% ----------------------------------------------------------------------- sort-context-on-expr [26] 100.0% [35] 632(2.7%) 0(0.0%) ??? ...-7.0/collects/racket/private/sort.rkt:369:3 generic-sort/key [42] 52.8% loop [54] 47.2% ----------------------------------------------------------------------- for-loop [28] 100.0% [36] 300(1.3%) 0(0.0%) for-loop ...val-private-mpfr/src/points.rkt:323:32 random-posit16 [43] 100.0% ----------------------------------------------------------------------- for-loop [22] 100.0% [37] 258(1.1%) 258(1.1%) ??? ...7.0/collects/racket/private/for.rkt:1208:14 ----------------------------------------------------------------------- for-loop [31] 100.0% [38] 1708(7.3%) 0(0.0%) atab-add-altn ...mpfr/src/core/alt-table.rkt:202:0 errors [45] 100.0% ----------------------------------------------------------------------- hash-ref! [33] 100.0% [39] 1170(5.0%) 0(0.0%) f9 ....0/collects/racket/match/compiler.rkt:507:40 map [46] 100.0% ----------------------------------------------------------------------- hash-ref! [33] 100.0% [40] 1170(5.0%) 0(0.0%) parse-loop15 ...s/racket/match/compiler.rkt:418:15 map [46] 49.9% loop [52] 37.9% loop [50] 12.1% ----------------------------------------------------------------------- for-loop [34] 100.0% [41] 1118(4.8%) 0(0.0%) one-iter ...rivate-mpfr/src/core/simplify.rkt:86:0 for-loop [47] 75.5% find-matches [49] 24.5% ----------------------------------------------------------------------- ??? [35] 100.0% [42] 334(1.4%) 0(0.0%) generic-sort/key .../racket/private/sort.rkt:156:2 copying-mergesort [48] 100.0% ----------------------------------------------------------------------- for-loop [36] 100.0% [43] 300(1.3%) 300(1.3%) random-posit16 ...softposit-rkt/softposit.rkt:64:0 ----------------------------------------------------------------------- for-loop [31] 100.0% [44] 270(1.2%) 0(0.0%) loop ...-private-mpfr/src/core/alt-table.rkt:176:2 map [46] 100.0% ----------------------------------------------------------------------- for-loop [27] 9.0% ??? [11] 44.7% atab-add-altn [38] 46.2% [45] 3694(15.8%) 0(0.0%) errors ...e/ival-private-mpfr/src/points.rkt:228:0 for-loop [51] 91.0% eval-prog [55] 9.0% ----------------------------------------------------------------------- parse-loop15 [40] 8.8% loop [44] 13.9% for-loop [8] 25.8% f9 [39] 51.5% [46] 1940(8.3%) 0(0.0%) map ...t-7.0/collects/racket/private/map.rkt:35:13 hash-ref! [33] 51.5% ??? [59] 25.8% loop [50] 13.9% loop [52] 8.8% ----------------------------------------------------------------------- one-iter [41] 100.0% [47] 844(3.6%) 0(0.0%) for-loop ...rivate-mpfr/src/core/simplify.rkt:95:2 loop [53] 100.0% ----------------------------------------------------------------------- generic-sort/key [42] 33.3% copying-mergesort [48] 66.7% [48] 334(1.4%) 0(0.0%) copying-mergesort ...racket/private/sort.rkt:129:8 copying-mergesort [48] 66.7% loop [54] 33.3% ----------------------------------------------------------------------- one-iter [41] 100.0% [49] 274(1.2%) 0(0.0%) find-matches ...te-mpfr/src/core/simplify.rkt:56:0 for-loop [56] 100.0% ----------------------------------------------------------------------- loop [30] 0.8% map [46] 1.0% make-exacts-walkup [32] 1.2% loop! [90] 1.9% parse-loop15 [40] 2.0% for-loop [8] 14.1% loop [50] 79.0% [50] 14188(60.6%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:40:19 loop [50] 79.0% ??? [66] 10.6% hash-ref! [33] 2.0% loop! [90] 1.9% ??? [59] 1.8% ulp-difference [68] 1.8% composed [57] 1.7% ??? [64] 1.0% ??? [73] 0.3% ----------------------------------------------------------------------- errors [45] 100.0% [51] 3360(14.4%) 554(2.4%) for-loop ...ival-private-mpfr/src/points.rkt:230:2 ??? [66] 58.4% ??? [63] 8.7% ??? [73] 8.6% point-error [65] 7.9% ----------------------------------------------------------------------- parse-loop15 [40] 0.7% map [46] 2.8% loop [52] 96.5% [52] 1170(5.0%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:54:19 loop [52] 96.5% ??? [60] 2.8% ??? [73] 0.7% ----------------------------------------------------------------------- for-loop [47] 100.0% [53] 844(3.6%) 0(0.0%) loop ...l-private-mpfr/src/core/simplify.rkt:100:4 apply-match [58] 100.0% ----------------------------------------------------------------------- ??? [35] 47.2% copying-mergesort [48] 52.8% [54] 632(2.7%) 0(0.0%) loop ...7.0/collects/racket/private/sort.rkt:96:12 bf [75] 31.0% ??? [73] 12.1% ----------------------------------------------------------------------- apply-match [58] 100.0% [67] 544(2.3%) 0(0.0%) for-loop ...rivate-mpfr/src/core/simplify.rkt:78:2 merge-egraph-nodes! [79] 50.0% dedup-children! [78] 50.0% ----------------------------------------------------------------------- loop [50] 48.6% point-error [65] 51.4% [68] 514(2.2%) 264(1.1%) ulp-difference ...-private-mpfr/src/float.rkt:14:0 keyword-apply [80] 48.6% ----------------------------------------------------------------------- posit16 [91] 50.1% ->flonum [82] 34.3% create-quire1633 [83] 3.8% double->quire16 [88] 3.7% ----------------------------------------------------------------------- ??? [66] 100.0% [74] 7058(30.2%) 1316(5.6%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 create-quire1633 [83] 29.1% big-posit16-mul [84] 21.8% big-posit16-sqrt [85] 13.6% double->posit16 [91] 12.2% big-posit16-add [87] 4.6% ----------------------------------------------------------------------- ??? [66] 100.0% [75] 4010(17.1%) 622(2.7%) ->bf ...ie/ival-private-mpfr/src/programs.rkt:62:0 bf [81] 84.5% ----------------------------------------------------------------------- compile16 [70] 100.0% [76] 334(1.4%) 0(0.0%) temp74_0 (unknown source) expand-single [86] 100.0% ----------------------------------------------------------------------- set [71] 100.0% [77] 300(1.3%) 300(1.3%) for-loop ...cts/racket/private/set-types.rkt:937:4 ----------------------------------------------------------------------- for-loop [67] 100.0% [78] 272(1.2%) 0(0.0%) dedup-children! ...e-mpfr/src/core/enode.rkt:199:0 loop [89] 100.0% ----------------------------------------------------------------------- for-loop [67] 100.0% [79] 272(1.2%) 0(0.0%) merge-egraph-nodes! ...r/src/core/egraph.rkt:145:0 loop! [90] 100.0% ----------------------------------------------------------------------- ulp-difference [68] 100.0% [80] 250(1.1%) 250(1.1%) keyword-apply ...lects/racket/private/kw.rkt:421:2 ----------------------------------------------------------------------- ->bf [75] 100.0% [81] 3388(14.5%) 348(1.5%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [106] 63.2% ??? [107] 26.5% ----------------------------------------------------------------------- ??? [73] 100.0% [82] 2652(11.3%) 2150(9.2%) ->flonum ...val-private-mpfr/src/programs.rkt:38:0 return/no-unsupplied [93] 18.9% ----------------------------------------------------------------------- create-quire1633 [83] 5.3% ??? [73] 12.5% ??? [74] 82.2% [83] 2350(10.0%) 496(2.1%) create-quire1633 ...tposit-rkt/softposit.rkt:175:0 double->posit16 [91] 78.9% create-quire1633 [83] 5.3% ----------------------------------------------------------------------- ??? [74] 100.0% [84] 1538(6.6%) 0(0.0%) big-posit16-mul .../src/syntax/softposit.rkt:110:0 bf* [92] 100.0% ----------------------------------------------------------------------- ??? [74] 100.0% [85] 960(4.1%) 0(0.0%) big-posit16-sqrt ...src/syntax/softposit.rkt:112:0 ??? [98] 100.0% ----------------------------------------------------------------------- temp74_0 [76] 100.0% [86] 334(1.4%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [94] 100.0% ----------------------------------------------------------------------- ??? [74] 100.0% [87] 324(1.4%) 0(0.0%) big-posit16-add .../src/syntax/softposit.rkt:108:0 ??? [98] 100.0% ----------------------------------------------------------------------- ??? [73] 100.0% [88] 290(1.2%) 0(0.0%) double->quire16 ...ftposit-rkt/softposit.rkt:316:0 get-ffi-obj* [97] 100.0% ----------------------------------------------------------------------- loop [89] 50.0% dedup-children! [78] 50.0% [89] 272(1.2%) 0(0.0%) loop ...racket-7.0/collects/racket/list.rkt:417:34 loop [89] 50.0% member [96] 50.0% ----------------------------------------------------------------------- loop [50] 50.0% merge-egraph-nodes! [79] 50.0% [90] 272(1.2%) 0(0.0%) loop! ...val-private-mpfr/src/core/enode.rkt:191:2 loop [50] 50.0% custom-set-union [95] 50.0% ----------------------------------------------------------------------- ??? [74] 13.1% create-quire1633 [83] 28.1% ??? [73] 58.8% [91] 6594(28.2%) 0(0.0%) double->posit16 ...ftposit-rkt/softposit.rkt:248:0 get-ffi-obj* [97] 100.0% ----------------------------------------------------------------------- big-posit16-mul [84] 100.0% [92] 1538(6.6%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [98] 100.0% ----------------------------------------------------------------------- ->flonum [82] 100.0% [93] 502(2.1%) 250(1.1%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 filter [100] 50.2% ----------------------------------------------------------------------- expand-single [86] 100.0% [94] 334(1.4%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [99] 100.0% ----------------------------------------------------------------------- loop! [90] 100.0% [95] 272(1.2%) 272(1.2%) custom-set-union ...et/private/set-types.rkt:168:0 ----------------------------------------------------------------------- loop [89] 100.0% [96] 272(1.2%) 272(1.2%) member (unknown source) ----------------------------------------------------------------------- double->quire16 [88] 4.2% double->posit16 [91] 95.8% [97] 6884(29.4%) 904(3.9%) get-ffi-obj* ...-7.0/collects/ffi/unsafe.rkt:209:2 get-ffi-lib9 [101] 86.9% ----------------------------------------------------------------------- big-posit16-add [87] 11.5% big-posit16-sqrt [85] 34.0% bf* [92] 54.5% [98] 2822(12.1%) 592(2.5%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [102] 54.8% bfsqrt [103] 24.2% ----------------------------------------------------------------------- expand-capturing-lifts [94] 100.0% [99] 334(1.4%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [104] 100.0% ----------------------------------------------------------------------- return/no-unsupplied [93] 100.0% [100] 252(1.1%) 252(1.1%) filter ...0/collects/racket/private/list.rkt:256:2 ----------------------------------------------------------------------- get-ffi-obj* [97] 100.0% [101] 5980(25.6%) 2596(11.1%) get-ffi-lib9 ...-7.0/collects/ffi/unsafe.rkt:121:0 get-cross-lib-search-dirs [105] 52.4% loop [109] 4.2% ----------------------------------------------------------------------- ??? [98] 100.0% [102] 1546(6.6%) 294(1.3%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 ??? [107] 81.0% ----------------------------------------------------------------------- ??? [98] 100.0% [103] 684(2.9%) 0(0.0%) bfsqrt ...lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [106] 100.0% ----------------------------------------------------------------------- lambda-clause-expander [99] 20.0% for-loop [108] 80.0% [104] 334(1.4%) 0(0.0%) finish-bodys (unknown source) for-loop [108] 100.0% ----------------------------------------------------------------------- get-ffi-lib9 [101] 100.0% [105] 3134(13.4%) 2844(12.2%) get-cross-lib-search-dirs ...rivate/dirs.rkt:168:7 ??? [110] 9.3% ----------------------------------------------------------------------- bfsqrt [103] 24.2% bf [81] 75.8% [106] 2826(12.1%) 2826(12.1%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ----------------------------------------------------------------------- bf [81] 41.8% bfmul [102] 58.2% [107] 2150(9.2%) 2150(9.2%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 ----------------------------------------------------------------------- fallback-loop [14] 12.5% for-loop [108] 25.0% finish-bodys [104] 62.5% [108] 334(1.4%) 334(1.4%) for-loop (unknown source) finish-bodys [104] 50.0% for-loop [108] 25.0% expand-identifier [5] 12.5% ----------------------------------------------------------------------- get-ffi-lib9 [101] 100.0% [109] 250(1.1%) 250(1.1%) loop ...lects/ffi/../racket/private/map.rkt:149:23 ----------------------------------------------------------------------- get-cross-lib-search-dirs [105]100.0% [110] 290(1.2%) 290(1.2%) ??? ...racket-7.0/collects/racket/promise.rkt:42:2 -----------------------------------------------------------------------